{"level":"warn","ts":"2026-08-28T06:02:41.30103Z","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-28T06:02:41.301125Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.196: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.196:2380","--initial-cluster=instance=https://162.253.55.196:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.196:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.196: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-28T06:02:41.301202Z","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-28T06:02:41.301218Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.196:2380"]} {"level":"info","ts":"2026-08-28T06:02:41.301241Z","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-28T06:02:41.301932Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"]} {"level":"info","ts":"2026-08-28T06:02:41.302004Z","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.196:2380"],"listen-peer-urls":["https://162.253.55.196:2380"],"advertise-client-urls":["https://162.253.55.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.196: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-28T06:02:41.309513Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.280283ms"} {"level":"info","ts":"2026-08-28T06:02:41.322332Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"40c23df05199fc95","cluster-id":"a4d434936ffe8e8"} {"level":"info","ts":"2026-08-28T06:02:41.322692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=()"} {"level":"info","ts":"2026-08-28T06:02:41.322714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became follower at term 0"} {"level":"info","ts":"2026-08-28T06:02:41.322721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 40c23df05199fc95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-28T06:02:41.32285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became follower at term 1"} {"level":"info","ts":"2026-08-28T06:02:41.322936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=(4666360266279746709)"} {"level":"warn","ts":"2026-08-28T06:02:41.331309Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-28T06:02:41.332577Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-28T06:02:41.338377Z","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-28T06:02:41.340061Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"40c23df05199fc95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-28T06:02:41.340179Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"40c23df05199fc95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-28T06:02:41.34021Z","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-28T06:02:41.342587Z","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-28T06:02:41.342611Z","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-28T06:02:41.343742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 switched to configuration voters=(4666360266279746709)"} {"level":"info","ts":"2026-08-28T06:02:41.34391Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a4d434936ffe8e8","local-member-id":"40c23df05199fc95","added-peer-id":"40c23df05199fc95","added-peer-peer-urls":["https://162.253.55.196:2380"]} {"level":"info","ts":"2026-08-28T06:02:41.348719Z","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-28T06:02:41.349009Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"40c23df05199fc95","initial-advertise-peer-urls":["https://162.253.55.196:2380"],"listen-peer-urls":["https://162.253.55.196:2380"],"advertise-client-urls":["https://162.253.55.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-28T06:02:41.349042Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-28T06:02:41.349131Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.196:2380"} {"level":"info","ts":"2026-08-28T06:02:41.349143Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.196:2380"} {"level":"info","ts":"2026-08-28T06:02:41.72344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 is starting a new election at term 1"} {"level":"info","ts":"2026-08-28T06:02:41.723526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-28T06:02:41.723558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 received MsgPreVoteResp from 40c23df05199fc95 at term 1"} {"level":"info","ts":"2026-08-28T06:02:41.723585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became candidate at term 2"} {"level":"info","ts":"2026-08-28T06:02:41.723596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 received MsgVoteResp from 40c23df05199fc95 at term 2"} {"level":"info","ts":"2026-08-28T06:02:41.723612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"40c23df05199fc95 became leader at term 2"} {"level":"info","ts":"2026-08-28T06:02:41.723632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 40c23df05199fc95 elected leader 40c23df05199fc95 at term 2"} {"level":"info","ts":"2026-08-28T06:02:41.72458Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"40c23df05199fc95","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.196:2379]}","request-path":"/0/members/40c23df05199fc95/attributes","cluster-id":"a4d434936ffe8e8","publish-timeout":"7s"} {"level":"info","ts":"2026-08-28T06:02:41.724685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-28T06:02:41.724763Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:02:41.724817Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-28T06:02:41.724969Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-28T06:02:41.725017Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-28T06:02:41.725561Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a4d434936ffe8e8","local-member-id":"40c23df05199fc95","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:02:41.725618Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:02:41.725635Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:02:41.728712Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-28T06:02:41.732762Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.196:2379"} {"level":"info","ts":"2026-08-28T06:02:46.09635Z","caller":"traceutil/trace.go:171","msg":"trace[1780542109] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"274.216342ms","start":"2026-08-28T06:02:45.822107Z","end":"2026-08-28T06:02:46.096323Z","steps":["trace[1780542109] 'process raft request' (duration: 274.067946ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:02:51.759018Z","caller":"traceutil/trace.go:171","msg":"trace[1773523202] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"139.172007ms","start":"2026-08-28T06:02:51.619822Z","end":"2026-08-28T06:02:51.758994Z","steps":["trace[1773523202] 'process raft request' (duration: 139.101125ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:02:51.759065Z","caller":"traceutil/trace.go:171","msg":"trace[1543796987] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"141.044831ms","start":"2026-08-28T06:02:51.617976Z","end":"2026-08-28T06:02:51.759021Z","steps":["trace[1543796987] 'process raft request' (duration: 96.591587ms)","trace[1543796987] 'compare' (duration: 44.148864ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:02:51.783713Z","caller":"traceutil/trace.go:171","msg":"trace[1467307196] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"101.040316ms","start":"2026-08-28T06:02:51.682654Z","end":"2026-08-28T06:02:51.783694Z","steps":["trace[1467307196] 'process raft request' (duration: 100.990114ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:02:51.783744Z","caller":"traceutil/trace.go:171","msg":"trace[175077347] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"103.737157ms","start":"2026-08-28T06:02:51.67999Z","end":"2026-08-28T06:02:51.783727Z","steps":["trace[175077347] 'process raft request' (duration: 103.569672ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:02:51.963434Z","caller":"traceutil/trace.go:171","msg":"trace[795481654] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"196.801844ms","start":"2026-08-28T06:02:51.766601Z","end":"2026-08-28T06:02:51.963403Z","steps":["trace[795481654] 'process raft request' (duration: 119.688322ms)","trace[795481654] 'compare' (duration: 76.977368ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:03:20.540082Z","caller":"traceutil/trace.go:171","msg":"trace[467957748] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"226.114243ms","start":"2026-08-28T06:03:20.313939Z","end":"2026-08-28T06:03:20.540053Z","steps":["trace[467957748] 'process raft request' (duration: 225.961689ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.889813Z","caller":"traceutil/trace.go:171","msg":"trace[726846586] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"563.108455ms","start":"2026-08-28T06:03:20.326665Z","end":"2026-08-28T06:03:20.889774Z","steps":["trace[726846586] 'process raft request' (duration: 562.928511ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.890352Z","caller":"traceutil/trace.go:171","msg":"trace[63705195] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"573.509717ms","start":"2026-08-28T06:03:20.316792Z","end":"2026-08-28T06:03:20.890302Z","steps":["trace[63705195] 'process raft request' (duration: 572.643125ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.890522Z","caller":"traceutil/trace.go:171","msg":"trace[1906597873] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"547.739836ms","start":"2026-08-28T06:03:20.342764Z","end":"2026-08-28T06:03:20.890504Z","steps":["trace[1906597873] 'process raft request' (duration: 546.998618ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.890428Z","caller":"traceutil/trace.go:171","msg":"trace[1355296610] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"538.057561ms","start":"2026-08-28T06:03:20.352326Z","end":"2026-08-28T06:03:20.890384Z","steps":["trace[1355296610] 'process raft request' (duration: 537.59121ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.890693Z","caller":"traceutil/trace.go:171","msg":"trace[963966671] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"547.596482ms","start":"2026-08-28T06:03:20.343082Z","end":"2026-08-28T06:03:20.890678Z","steps":["trace[963966671] 'process raft request' (duration: 546.791463ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.890729Z","caller":"traceutil/trace.go:171","msg":"trace[1166255507] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"533.142646ms","start":"2026-08-28T06:03:20.357578Z","end":"2026-08-28T06:03:20.89072Z","steps":["trace[1166255507] 'process raft request' (duration: 532.406258ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.890804Z","caller":"traceutil/trace.go:171","msg":"trace[358774708] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"552.944768ms","start":"2026-08-28T06:03:20.337852Z","end":"2026-08-28T06:03:20.890796Z","steps":["trace[358774708] 'process raft request' (duration: 551.78784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.89088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.316758Z","time spent":"573.684022ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T06:03:20.890937Z","caller":"traceutil/trace.go:171","msg":"trace[1896401878] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"550.803303ms","start":"2026-08-28T06:03:20.340041Z","end":"2026-08-28T06:03:20.890844Z","steps":["trace[1896401878] 'process raft request' (duration: 549.637765ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.891055Z","caller":"traceutil/trace.go:171","msg":"trace[309795586] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"522.193431ms","start":"2026-08-28T06:03:20.368662Z","end":"2026-08-28T06:03:20.890856Z","steps":["trace[309795586] 'process raft request' (duration: 521.602926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.89113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.340021Z","time spent":"551.041421ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T06:03:20.890217Z","caller":"traceutil/trace.go:171","msg":"trace[2078581604] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"549.598034ms","start":"2026-08-28T06:03:20.340598Z","end":"2026-08-28T06:03:20.890196Z","steps":["trace[2078581604] 'process raft request' (duration: 549.127292ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.89172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.34059Z","time spent":"551.01099ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.891782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.34274Z","time spent":"547.814798ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.891953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.32665Z","time spent":"563.32894ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.891526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.368616Z","time spent":"522.828347ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.892131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.352311Z","time spent":"538.275237ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.892181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.343072Z","time spent":"547.655815ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.892258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.337822Z","time spent":"553.00462ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:20.891042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.357562Z","time spent":"533.187838ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T06:03:20.901908Z","caller":"traceutil/trace.go:171","msg":"trace[1851037091] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:548; }","duration":"552.370683ms","start":"2026-08-28T06:03:20.349514Z","end":"2026-08-28T06:03:20.901885Z","steps":["trace[1851037091] 'read index received' (duration: 191.132397ms)","trace[1851037091] 'applied index is now lower than readState.Index' (duration: 361.236966ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:03:20.902046Z","caller":"traceutil/trace.go:171","msg":"trace[786765898] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"355.570812ms","start":"2026-08-28T06:03:20.54645Z","end":"2026-08-28T06:03:20.902021Z","steps":["trace[786765898] 'process raft request' (duration: 355.226193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.902188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.546424Z","time spent":"355.718976ms","remote":"127.0.0.1:51202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T06:03:20.902322Z","caller":"traceutil/trace.go:171","msg":"trace[1672355912] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"355.08863ms","start":"2026-08-28T06:03:20.547223Z","end":"2026-08-28T06:03:20.902312Z","steps":["trace[1672355912] 'process raft request' (duration: 354.496045ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.902478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.756236ms","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-08-28T06:03:20.902536Z","caller":"traceutil/trace.go:171","msg":"trace[560758529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:544; }","duration":"539.841147ms","start":"2026-08-28T06:03:20.362685Z","end":"2026-08-28T06:03:20.902526Z","steps":["trace[560758529] 'agreement among raft nodes before linearized reading' (duration: 539.700664ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:20.90255Z","caller":"traceutil/trace.go:171","msg":"trace[882978820] transaction","detail":"{read_only:false; number_of_response:1; response_revision:542; }","duration":"354.532355ms","start":"2026-08-28T06:03:20.547998Z","end":"2026-08-28T06:03:20.90253Z","steps":["trace[882978820] 'process raft request' (duration: 353.773006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.902675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.87961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-28T06:03:20.902706Z","caller":"traceutil/trace.go:171","msg":"trace[1221172325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"256.936412ms","start":"2026-08-28T06:03:20.645761Z","end":"2026-08-28T06:03:20.902697Z","steps":["trace[1221172325] 'agreement among raft nodes before linearized reading' (duration: 256.819029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.902501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.960069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:03:20.902883Z","caller":"traceutil/trace.go:171","msg":"trace[1305456740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:544; }","duration":"553.386859ms","start":"2026-08-28T06:03:20.349478Z","end":"2026-08-28T06:03:20.902865Z","steps":["trace[1305456740] 'agreement among raft nodes before linearized reading' (duration: 552.841395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.903014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.349466Z","time spent":"553.530553ms","remote":"127.0.0.1:50728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-28T06:03:20.903194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.547187Z","time spent":"355.957612ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T06:03:20.902803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.547988Z","time spent":"354.601728ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T06:03:20.902563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.362672Z","time spent":"539.884108ms","remote":"127.0.0.1:50938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-28T06:03:20.901735Z","caller":"traceutil/trace.go:171","msg":"trace[532691890] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"411.015592ms","start":"2026-08-28T06:03:20.490697Z","end":"2026-08-28T06:03:20.901713Z","steps":["trace[532691890] 'process raft request' (duration: 410.782397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:20.904364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:20.490663Z","time spent":"413.588748ms","remote":"127.0.0.1:50754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T06:03:27.492519Z","caller":"traceutil/trace.go:171","msg":"trace[1749724620] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"126.547345ms","start":"2026-08-28T06:03:27.365927Z","end":"2026-08-28T06:03:27.492474Z","steps":["trace[1749724620] 'process raft request' (duration: 119.939659ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:28.016561Z","caller":"traceutil/trace.go:171","msg":"trace[678304547] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"264.03992ms","start":"2026-08-28T06:03:27.752498Z","end":"2026-08-28T06:03:28.016538Z","steps":["trace[678304547] 'read index received' (duration: 263.877456ms)","trace[678304547] 'applied index is now lower than readState.Index' (duration: 161.374µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:03:28.016644Z","caller":"traceutil/trace.go:171","msg":"trace[589599699] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"452.290351ms","start":"2026-08-28T06:03:27.564331Z","end":"2026-08-28T06:03:28.016621Z","steps":["trace[589599699] 'process raft request' (duration: 452.095256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:28.016767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.252045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-28T06:03:28.016806Z","caller":"traceutil/trace.go:171","msg":"trace[1676496006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"264.335107ms","start":"2026-08-28T06:03:27.752461Z","end":"2026-08-28T06:03:28.016796Z","steps":["trace[1676496006] 'agreement among raft nodes before linearized reading' (duration: 264.179243ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:28.016826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:27.564301Z","time spent":"452.454615ms","remote":"127.0.0.1:50912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:03:28.016888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.187036ms","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-28T06:03:28.016971Z","caller":"traceutil/trace.go:171","msg":"trace[590957544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"132.30995ms","start":"2026-08-28T06:03:27.884641Z","end":"2026-08-28T06:03:28.016951Z","steps":["trace[590957544] 'agreement among raft nodes before linearized reading' (duration: 132.040234ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:28.13299Z","caller":"traceutil/trace.go:171","msg":"trace[656588901] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"103.648641ms","start":"2026-08-28T06:03:28.029309Z","end":"2026-08-28T06:03:28.132958Z","steps":["trace[656588901] 'process raft request' (duration: 103.242952ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:28.132979Z","caller":"traceutil/trace.go:171","msg":"trace[100976706] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"112.046749ms","start":"2026-08-28T06:03:28.020912Z","end":"2026-08-28T06:03:28.132958Z","steps":["trace[100976706] 'read index received' (duration: 83.149048ms)","trace[100976706] 'applied index is now lower than readState.Index' (duration: 28.896501ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:03:28.132908Z","caller":"traceutil/trace.go:171","msg":"trace[743433628] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"112.200812ms","start":"2026-08-28T06:03:28.02065Z","end":"2026-08-28T06:03:28.13285Z","steps":["trace[743433628] 'process raft request' (duration: 83.387433ms)","trace[743433628] 'compare' (duration: 27.99661ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:03:28.133274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.341966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-28T06:03:28.133323Z","caller":"traceutil/trace.go:171","msg":"trace[747354359] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:644; }","duration":"112.420698ms","start":"2026-08-28T06:03:28.020888Z","end":"2026-08-28T06:03:28.133308Z","steps":["trace[747354359] 'agreement among raft nodes before linearized reading' (duration: 112.311775ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:23.366484Z","caller":"traceutil/trace.go:171","msg":"trace[401329802] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"102.316126ms","start":"2026-08-28T06:04:23.264145Z","end":"2026-08-28T06:04:23.366461Z","steps":["trace[401329802] 'process raft request' (duration: 102.169083ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:23.401055Z","caller":"traceutil/trace.go:171","msg":"trace[107275798] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"136.194444ms","start":"2026-08-28T06:04:23.264834Z","end":"2026-08-28T06:04:23.401029Z","steps":["trace[107275798] 'process raft request' (duration: 136.083062ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:39.712729Z","caller":"traceutil/trace.go:171","msg":"trace[1208141775] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"102.05783ms","start":"2026-08-28T06:04:39.610635Z","end":"2026-08-28T06:04:39.712693Z","steps":["trace[1208141775] 'process raft request' (duration: 101.835827ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:46.881859Z","caller":"traceutil/trace.go:171","msg":"trace[458301319] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"157.710556ms","start":"2026-08-28T06:04:46.724096Z","end":"2026-08-28T06:04:46.881807Z","steps":["trace[458301319] 'process raft request' (duration: 157.457383ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:11.07336Z","caller":"traceutil/trace.go:171","msg":"trace[2042642516] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"276.346397ms","start":"2026-08-28T06:05:10.796988Z","end":"2026-08-28T06:05:11.073334Z","steps":["trace[2042642516] 'process raft request' (duration: 276.204615ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:11.307164Z","caller":"traceutil/trace.go:171","msg":"trace[703884643] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"219.286867ms","start":"2026-08-28T06:05:11.087857Z","end":"2026-08-28T06:05:11.307144Z","steps":["trace[703884643] 'process raft request' (duration: 219.145315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:05:11.590947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.61393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T06:05:11.591244Z","caller":"traceutil/trace.go:171","msg":"trace[1268234168] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"277.516303ms","start":"2026-08-28T06:05:11.3137Z","end":"2026-08-28T06:05:11.591216Z","steps":["trace[1268234168] 'process raft request' (duration: 90.383126ms)","trace[1268234168] 'compare' (duration: 186.460788ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:05:11.591499Z","caller":"traceutil/trace.go:171","msg":"trace[84258471] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"276.929586ms","start":"2026-08-28T06:05:11.314552Z","end":"2026-08-28T06:05:11.591481Z","steps":["trace[84258471] 'process raft request' (duration: 276.891405ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:11.591562Z","caller":"traceutil/trace.go:171","msg":"trace[1815153969] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"277.563424ms","start":"2026-08-28T06:05:11.313987Z","end":"2026-08-28T06:05:11.591551Z","steps":["trace[1815153969] 'process raft request' (duration: 277.26042ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:11.591824Z","caller":"traceutil/trace.go:171","msg":"trace[1169126115] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"277.243539ms","start":"2026-08-28T06:05:11.314534Z","end":"2026-08-28T06:05:11.591778Z","steps":["trace[1169126115] 'process raft request' (duration: 276.862715ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:27.68156Z","caller":"traceutil/trace.go:171","msg":"trace[445014948] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"311.890198ms","start":"2026-08-28T06:05:27.369653Z","end":"2026-08-28T06:05:27.681543Z","steps":["trace[445014948] 'process raft request' (duration: 311.774936ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:05:27.681689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:05:27.369629Z","time spent":"311.998399ms","remote":"127.0.0.1:50938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T06:05:49.87842Z","caller":"traceutil/trace.go:171","msg":"trace[1557287694] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"106.468781ms","start":"2026-08-28T06:05:49.771892Z","end":"2026-08-28T06:05:49.878361Z","steps":["trace[1557287694] 'process raft request' (duration: 106.107327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:05:50.44906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.782245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-28T06:05:50.449155Z","caller":"traceutil/trace.go:171","msg":"trace[1816547027] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"150.342523ms","start":"2026-08-28T06:05:50.298775Z","end":"2026-08-28T06:05:50.449117Z","steps":["trace[1816547027] 'process raft request' (duration: 143.918104ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:50.449199Z","caller":"traceutil/trace.go:171","msg":"trace[126263083] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2180; }","duration":"194.975707ms","start":"2026-08-28T06:05:50.254204Z","end":"2026-08-28T06:05:50.44918Z","steps":["trace[126263083] 'count revisions from in-memory index tree' (duration: 194.648163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:05:51.097916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.09652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-28T06:05:51.098041Z","caller":"traceutil/trace.go:171","msg":"trace[1668441598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2183; }","duration":"265.233371ms","start":"2026-08-28T06:05:50.832779Z","end":"2026-08-28T06:05:51.098012Z","steps":["trace[1668441598] 'range keys from in-memory index tree' (duration: 264.829956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:05:51.098525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.940969ms","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-28T06:05:51.09859Z","caller":"traceutil/trace.go:171","msg":"trace[1558050861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2183; }","duration":"247.071791ms","start":"2026-08-28T06:05:50.851502Z","end":"2026-08-28T06:05:51.098574Z","steps":["trace[1558050861] 'range keys from in-memory index tree' (duration: 246.731167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:05:51.098901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.695609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-28T06:05:51.098953Z","caller":"traceutil/trace.go:171","msg":"trace[1014994636] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2183; }","duration":"115.7964ms","start":"2026-08-28T06:05:50.983141Z","end":"2026-08-28T06:05:51.098937Z","steps":["trace[1014994636] 'range keys from in-memory index tree' (duration: 115.533257ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:51.126584Z","caller":"traceutil/trace.go:171","msg":"trace[711388268] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"129.204043ms","start":"2026-08-28T06:05:50.99734Z","end":"2026-08-28T06:05:51.126544Z","steps":["trace[711388268] 'process raft request' (duration: 128.92646ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:51.371644Z","caller":"traceutil/trace.go:171","msg":"trace[122774224] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"259.513359ms","start":"2026-08-28T06:05:51.112079Z","end":"2026-08-28T06:05:51.371593Z","steps":["trace[122774224] 'process raft request' (duration: 209.132756ms)","trace[122774224] 'compare' (duration: 50.024588ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:05:51.371956Z","caller":"traceutil/trace.go:171","msg":"trace[681945145] linearizableReadLoop","detail":"{readStateIndex:2272; appliedIndex:2270; }","duration":"160.654905ms","start":"2026-08-28T06:05:51.211239Z","end":"2026-08-28T06:05:51.371893Z","steps":["trace[681945145] 'read index received' (duration: 110.009279ms)","trace[681945145] 'applied index is now lower than readState.Index' (duration: 50.642896ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:05:51.372263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.968729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-08-28T06:05:51.37239Z","caller":"traceutil/trace.go:171","msg":"trace[512361962] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2187; }","duration":"161.126411ms","start":"2026-08-28T06:05:51.211169Z","end":"2026-08-28T06:05:51.372296Z","steps":["trace[512361962] 'agreement among raft nodes before linearized reading' (duration: 160.865318ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:51.371695Z","caller":"traceutil/trace.go:171","msg":"trace[924914560] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"106.701988ms","start":"2026-08-28T06:05:51.264958Z","end":"2026-08-28T06:05:51.37166Z","steps":["trace[924914560] 'process raft request' (duration: 106.634028ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:05:51.372684Z","caller":"traceutil/trace.go:171","msg":"trace[1953713906] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"259.527238ms","start":"2026-08-28T06:05:51.113114Z","end":"2026-08-28T06:05:51.372641Z","steps":["trace[1953713906] 'process raft request' (duration: 258.384715ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:07:22.94291Z","caller":"traceutil/trace.go:171","msg":"trace[70070690] linearizableReadLoop","detail":"{readStateIndex:2894; appliedIndex:2893; }","duration":"232.77333ms","start":"2026-08-28T06:07:22.710116Z","end":"2026-08-28T06:07:22.94289Z","steps":["trace[70070690] 'read index received' (duration: 232.729578ms)","trace[70070690] 'applied index is now lower than readState.Index' (duration: 42.672µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:07:22.943025Z","caller":"traceutil/trace.go:171","msg":"trace[846777843] transaction","detail":"{read_only:false; response_revision:2788; number_of_response:1; }","duration":"234.393866ms","start":"2026-08-28T06:07:22.708618Z","end":"2026-08-28T06:07:22.943012Z","steps":["trace[846777843] 'process raft request' (duration: 234.120593ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:07:22.943207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.074334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-28T06:07:22.943237Z","caller":"traceutil/trace.go:171","msg":"trace[102981615] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2788; }","duration":"233.134466ms","start":"2026-08-28T06:07:22.710091Z","end":"2026-08-28T06:07:22.943226Z","steps":["trace[102981615] 'agreement among raft nodes before linearized reading' (duration: 233.026111ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:07:22.974291Z","caller":"traceutil/trace.go:171","msg":"trace[1101035562] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"215.228226ms","start":"2026-08-28T06:07:22.759042Z","end":"2026-08-28T06:07:22.97427Z","steps":["trace[1101035562] 'process raft request' (duration: 214.559166ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:07:28.303172Z","caller":"traceutil/trace.go:171","msg":"trace[1397434320] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"106.520237ms","start":"2026-08-28T06:07:28.196616Z","end":"2026-08-28T06:07:28.303136Z","steps":["trace[1397434320] 'process raft request' (duration: 106.278596ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:07:28.360103Z","caller":"traceutil/trace.go:171","msg":"trace[1998528482] linearizableReadLoop","detail":"{readStateIndex:2921; appliedIndex:2919; }","duration":"113.210585ms","start":"2026-08-28T06:07:28.246859Z","end":"2026-08-28T06:07:28.36007Z","steps":["trace[1998528482] 'read index received' (duration: 55.993505ms)","trace[1998528482] 'applied index is now lower than readState.Index' (duration: 57.21609ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:07:28.360263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.372572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:07:28.360308Z","caller":"traceutil/trace.go:171","msg":"trace[1713656922] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2814; }","duration":"113.467927ms","start":"2026-08-28T06:07:28.246824Z","end":"2026-08-28T06:07:28.360292Z","steps":["trace[1713656922] 'agreement among raft nodes before linearized reading' (duration: 113.354752ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:07:28.360667Z","caller":"traceutil/trace.go:171","msg":"trace[848503306] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"149.752833ms","start":"2026-08-28T06:07:28.210903Z","end":"2026-08-28T06:07:28.360656Z","steps":["trace[848503306] 'process raft request' (duration: 149.00408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:11:59.419271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.375607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-28T06:11:59.419375Z","caller":"traceutil/trace.go:171","msg":"trace[1019973696] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5002; }","duration":"178.508219ms","start":"2026-08-28T06:11:59.240842Z","end":"2026-08-28T06:11:59.419351Z","steps":["trace[1019973696] 'range keys from in-memory index tree' (duration: 178.229814ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:11:59.626039Z","caller":"traceutil/trace.go:171","msg":"trace[1567120032] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"241.194717ms","start":"2026-08-28T06:11:59.384812Z","end":"2026-08-28T06:11:59.626007Z","steps":["trace[1567120032] 'process raft request' (duration: 162.769199ms)","trace[1567120032] 'compare' (duration: 77.324536ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:11:59.626334Z","caller":"traceutil/trace.go:171","msg":"trace[1404327689] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"241.044094ms","start":"2026-08-28T06:11:59.385258Z","end":"2026-08-28T06:11:59.626303Z","steps":["trace[1404327689] 'process raft request' (duration: 240.673547ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:11:59.626604Z","caller":"traceutil/trace.go:171","msg":"trace[1167885658] linearizableReadLoop","detail":"{readStateIndex:5194; appliedIndex:5192; }","duration":"206.902888ms","start":"2026-08-28T06:11:59.419686Z","end":"2026-08-28T06:11:59.626589Z","steps":["trace[1167885658] 'read index received' (duration: 127.906388ms)","trace[1167885658] 'applied index is now lower than readState.Index' (duration: 78.99531ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:11:59.626545Z","caller":"traceutil/trace.go:171","msg":"trace[83673233] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"198.615099ms","start":"2026-08-28T06:11:59.427862Z","end":"2026-08-28T06:11:59.626477Z","steps":["trace[83673233] 'process raft request' (duration: 198.558538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:11:59.62677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.818879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-28T06:11:59.626806Z","caller":"traceutil/trace.go:171","msg":"trace[923004748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5007; }","duration":"237.915171ms","start":"2026-08-28T06:11:59.38888Z","end":"2026-08-28T06:11:59.626795Z","steps":["trace[923004748] 'agreement among raft nodes before linearized reading' (duration: 237.789688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:11:59.626925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.737396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-28T06:11:59.626953Z","caller":"traceutil/trace.go:171","msg":"trace[64106458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5007; }","duration":"238.814338ms","start":"2026-08-28T06:11:59.388131Z","end":"2026-08-28T06:11:59.626945Z","steps":["trace[64106458] 'agreement among raft nodes before linearized reading' (duration: 238.743946ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:11:59.627032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.494219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:11:59.627021Z","caller":"traceutil/trace.go:171","msg":"trace[1826113941] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"202.536549ms","start":"2026-08-28T06:11:59.424466Z","end":"2026-08-28T06:11:59.627003Z","steps":["trace[1826113941] 'process raft request' (duration: 201.712832ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:11:59.627188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.641611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4396fc6d-c24e-4203-a2af-ccaa8ab9d46f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-28T06:11:59.627221Z","caller":"traceutil/trace.go:171","msg":"trace[1593861243] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4396fc6d-c24e-4203-a2af-ccaa8ab9d46f; range_end:; response_count:1; response_revision:5007; }","duration":"172.716912ms","start":"2026-08-28T06:11:59.454494Z","end":"2026-08-28T06:11:59.627211Z","steps":["trace[1593861243] 'agreement among raft nodes before linearized reading' (duration: 172.63157ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:11:59.6271Z","caller":"traceutil/trace.go:171","msg":"trace[1034409191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5007; }","duration":"203.51933ms","start":"2026-08-28T06:11:59.423531Z","end":"2026-08-28T06:11:59.62705Z","steps":["trace[1034409191] 'agreement among raft nodes before linearized reading' (duration: 203.481749ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:11:59.898901Z","caller":"traceutil/trace.go:171","msg":"trace[238845793] linearizableReadLoop","detail":"{readStateIndex:5199; appliedIndex:5198; }","duration":"102.071711ms","start":"2026-08-28T06:11:59.796799Z","end":"2026-08-28T06:11:59.898871Z","steps":["trace[238845793] 'read index received' (duration: 101.868257ms)","trace[238845793] 'applied index is now lower than readState.Index' (duration: 202.574µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:11:59.898943Z","caller":"traceutil/trace.go:171","msg":"trace[1536422096] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"113.375001ms","start":"2026-08-28T06:11:59.785538Z","end":"2026-08-28T06:11:59.898913Z","steps":["trace[1536422096] 'process raft request' (duration: 113.179187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:11:59.899208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.391067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-28T06:11:59.89952Z","caller":"traceutil/trace.go:171","msg":"trace[1843943575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5010; }","duration":"102.737525ms","start":"2026-08-28T06:11:59.796758Z","end":"2026-08-28T06:11:59.899496Z","steps":["trace[1843943575] 'agreement among raft nodes before linearized reading' (duration: 102.252615ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:12:00.105203Z","caller":"traceutil/trace.go:171","msg":"trace[1575536290] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"142.654706ms","start":"2026-08-28T06:11:59.962522Z","end":"2026-08-28T06:12:00.105177Z","steps":["trace[1575536290] 'process raft request' (duration: 142.500313ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:12:00.105428Z","caller":"traceutil/trace.go:171","msg":"trace[1228358328] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"142.358339ms","start":"2026-08-28T06:11:59.963039Z","end":"2026-08-28T06:12:00.105397Z","steps":["trace[1228358328] 'process raft request' (duration: 142.094894ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:12:00.105433Z","caller":"traceutil/trace.go:171","msg":"trace[1467391553] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"106.004908ms","start":"2026-08-28T06:11:59.999409Z","end":"2026-08-28T06:12:00.105414Z","steps":["trace[1467391553] 'process raft request' (duration: 105.888355ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:12:00.105442Z","caller":"traceutil/trace.go:171","msg":"trace[1914120809] linearizableReadLoop","detail":"{readStateIndex:5205; appliedIndex:5202; }","duration":"142.437781ms","start":"2026-08-28T06:11:59.962973Z","end":"2026-08-28T06:12:00.105411Z","steps":["trace[1914120809] 'read index received' (duration: 37.595917ms)","trace[1914120809] 'applied index is now lower than readState.Index' (duration: 104.840844ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:12:00.105629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.635365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4396fc6d-c24e-4203-a2af-ccaa8ab9d46f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-28T06:12:00.105698Z","caller":"traceutil/trace.go:171","msg":"trace[608488398] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4396fc6d-c24e-4203-a2af-ccaa8ab9d46f; range_end:; response_count:1; response_revision:5018; }","duration":"142.85166ms","start":"2026-08-28T06:11:59.962834Z","end":"2026-08-28T06:12:00.105686Z","steps":["trace[608488398] 'agreement among raft nodes before linearized reading' (duration: 142.647596ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:12:00.105372Z","caller":"traceutil/trace.go:171","msg":"trace[682201196] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"143.339869ms","start":"2026-08-28T06:11:59.962004Z","end":"2026-08-28T06:12:00.105344Z","steps":["trace[682201196] 'process raft request' (duration: 133.191673ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:12:18.75297Z","caller":"traceutil/trace.go:171","msg":"trace[143402901] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"373.015746ms","start":"2026-08-28T06:12:18.379907Z","end":"2026-08-28T06:12:18.752923Z","steps":["trace[143402901] 'process raft request' (duration: 372.78614ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:12:18.753087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.022737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-28T06:12:18.753168Z","caller":"traceutil/trace.go:171","msg":"trace[1257460278] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:5230; }","duration":"344.17056ms","start":"2026-08-28T06:12:18.408984Z","end":"2026-08-28T06:12:18.753155Z","steps":["trace[1257460278] 'agreement among raft nodes before linearized reading' (duration: 344.020947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:12:18.75321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:12:18.408941Z","time spent":"344.259452ms","remote":"127.0.0.1:51068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-08-28T06:12:18.753429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:12:18.379874Z","time spent":"373.175638ms","remote":"127.0.0.1:50832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11904,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T06:12:18.752957Z","caller":"traceutil/trace.go:171","msg":"trace[1348779465] linearizableReadLoop","detail":"{readStateIndex:5425; appliedIndex:5424; }","duration":"343.841064ms","start":"2026-08-28T06:12:18.409043Z","end":"2026-08-28T06:12:18.752884Z","steps":["trace[1348779465] 'read index received' (duration: 343.568758ms)","trace[1348779465] 'applied index is now lower than readState.Index' (duration: 271.266µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:12:41.979366Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2887} {"level":"info","ts":"2026-08-28T06:12:42.057704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2887,"took":"76.817235ms","hash":4069556012,"current-db-size-bytes":52400128,"current-db-size":"52 MB","current-db-size-in-use-bytes":27828224,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-28T06:12:42.057784Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4069556012,"revision":2887,"compact-revision":-1} {"level":"info","ts":"2026-08-28T06:17:41.98642Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5374} {"level":"info","ts":"2026-08-28T06:17:42.107016Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5374,"took":"118.688649ms","hash":516341098,"current-db-size-bytes":52400128,"current-db-size":"52 MB","current-db-size-in-use-bytes":18620416,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-28T06:17:42.107087Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":516341098,"revision":5374,"compact-revision":2887}