{"level":"warn","ts":"2026-09-25T15:01:23.520395Z","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-25T15:01:23.520509Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.77: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.77:2380","--initial-cluster=instance=https://162.253.55.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.77: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-25T15:01:23.520589Z","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-25T15:01:23.520601Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.77:2380"]} {"level":"info","ts":"2026-09-25T15:01:23.520633Z","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-25T15:01:23.52129Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.77:2379"]} {"level":"info","ts":"2026-09-25T15:01:23.521363Z","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.77:2380"],"listen-peer-urls":["https://162.253.55.77:2380"],"advertise-client-urls":["https://162.253.55.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.77: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-25T15:01:23.526609Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.017976ms"} {"level":"info","ts":"2026-09-25T15:01:23.535072Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e0199b9aba0b7bc","cluster-id":"f6bbdc6c581f37e5"} {"level":"info","ts":"2026-09-25T15:01:23.535133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc switched to configuration voters=()"} {"level":"info","ts":"2026-09-25T15:01:23.535153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became follower at term 0"} {"level":"info","ts":"2026-09-25T15:01:23.535167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e0199b9aba0b7bc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-25T15:01:23.535178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became follower at term 1"} {"level":"info","ts":"2026-09-25T15:01:23.535216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc switched to configuration voters=(2162178318841984956)"} {"level":"warn","ts":"2026-09-25T15:01:23.541697Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-25T15:01:23.543701Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-25T15:01:23.544995Z","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-25T15:01:23.547268Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e0199b9aba0b7bc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-25T15:01:23.547955Z","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-25T15:01:23.548034Z","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-25T15:01:23.548044Z","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-25T15:01:23.548735Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e0199b9aba0b7bc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-25T15:01:23.549405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc switched to configuration voters=(2162178318841984956)"} {"level":"info","ts":"2026-09-25T15:01:23.549483Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f6bbdc6c581f37e5","local-member-id":"1e0199b9aba0b7bc","added-peer-id":"1e0199b9aba0b7bc","added-peer-peer-urls":["https://162.253.55.77:2380"]} {"level":"info","ts":"2026-09-25T15:01:23.550954Z","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-25T15:01:23.551074Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.77:2380"} {"level":"info","ts":"2026-09-25T15:01:23.551101Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.77:2380"} {"level":"info","ts":"2026-09-25T15:01:23.551227Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e0199b9aba0b7bc","initial-advertise-peer-urls":["https://162.253.55.77:2380"],"listen-peer-urls":["https://162.253.55.77:2380"],"advertise-client-urls":["https://162.253.55.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-25T15:01:23.551248Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-25T15:01:24.036311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc is starting a new election at term 1"} {"level":"info","ts":"2026-09-25T15:01:24.036368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became pre-candidate at term 1"} {"level":"info","ts":"2026-09-25T15:01:24.036385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc received MsgPreVoteResp from 1e0199b9aba0b7bc at term 1"} {"level":"info","ts":"2026-09-25T15:01:24.036516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became candidate at term 2"} {"level":"info","ts":"2026-09-25T15:01:24.036532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc received MsgVoteResp from 1e0199b9aba0b7bc at term 2"} {"level":"info","ts":"2026-09-25T15:01:24.036658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e0199b9aba0b7bc became leader at term 2"} {"level":"info","ts":"2026-09-25T15:01:24.036676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e0199b9aba0b7bc elected leader 1e0199b9aba0b7bc at term 2"} {"level":"info","ts":"2026-09-25T15:01:24.044656Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T15:01:24.045369Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e0199b9aba0b7bc","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.77:2379]}","request-path":"/0/members/1e0199b9aba0b7bc/attributes","cluster-id":"f6bbdc6c581f37e5","publish-timeout":"7s"} {"level":"info","ts":"2026-09-25T15:01:24.04557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-25T15:01:24.045585Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-25T15:01:24.046011Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f6bbdc6c581f37e5","local-member-id":"1e0199b9aba0b7bc","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T15:01:24.046181Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-25T15:01:24.046214Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T15:01:24.04622Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-25T15:01:24.046257Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T15:01:24.04811Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.77:2379"} {"level":"info","ts":"2026-09-25T15:01:24.048373Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-25T15:01:26.71587Z","caller":"traceutil/trace.go:171","msg":"trace[67310173] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"165.518105ms","start":"2026-09-25T15:01:26.550321Z","end":"2026-09-25T15:01:26.715839Z","steps":["trace[67310173] 'read index received' (duration: 165.331371ms)","trace[67310173] 'applied index is now lower than readState.Index' (duration: 184.954µs)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:01:26.71595Z","caller":"traceutil/trace.go:171","msg":"trace[1551180097] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"166.575164ms","start":"2026-09-25T15:01:26.549308Z","end":"2026-09-25T15:01:26.715883Z","steps":["trace[1551180097] 'process raft request' (duration: 166.34732ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:01:26.716341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.931443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-25T15:01:26.716516Z","caller":"traceutil/trace.go:171","msg":"trace[1475067751] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:75; }","duration":"166.194698ms","start":"2026-09-25T15:01:26.550295Z","end":"2026-09-25T15:01:26.71649Z","steps":["trace[1475067751] 'agreement among raft nodes before linearized reading' (duration: 165.725819ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:01:26.964791Z","caller":"traceutil/trace.go:171","msg":"trace[1847507135] linearizableReadLoop","detail":"{readStateIndex:80; appliedIndex:79; }","duration":"240.49266ms","start":"2026-09-25T15:01:26.724264Z","end":"2026-09-25T15:01:26.964756Z","steps":["trace[1847507135] 'read index received' (duration: 172.047098ms)","trace[1847507135] 'applied index is now lower than readState.Index' (duration: 68.444302ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:01:26.965033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.699024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-25T15:01:26.965096Z","caller":"traceutil/trace.go:171","msg":"trace[2102580225] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:76; }","duration":"240.822657ms","start":"2026-09-25T15:01:26.724234Z","end":"2026-09-25T15:01:26.965057Z","steps":["trace[2102580225] 'agreement among raft nodes before linearized reading' (duration: 240.649523ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:01:26.965278Z","caller":"traceutil/trace.go:171","msg":"trace[1655544795] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"241.312886ms","start":"2026-09-25T15:01:26.723877Z","end":"2026-09-25T15:01:26.96519Z","steps":["trace[1655544795] 'process raft request' (duration: 172.446477ms)","trace[1655544795] 'compare' (duration: 68.244918ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:01:27.367532Z","caller":"traceutil/trace.go:171","msg":"trace[675942630] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"117.917526ms","start":"2026-09-25T15:01:27.249574Z","end":"2026-09-25T15:01:27.367491Z","steps":["trace[675942630] 'process raft request' (duration: 112.955152ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:05.36053Z","caller":"traceutil/trace.go:171","msg":"trace[922753309] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"145.439363ms","start":"2026-09-25T15:02:05.215058Z","end":"2026-09-25T15:02:05.360497Z","steps":["trace[922753309] 'process raft request' (duration: 141.407117ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:05.361165Z","caller":"traceutil/trace.go:171","msg":"trace[1447146411] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"141.63961ms","start":"2026-09-25T15:02:05.219498Z","end":"2026-09-25T15:02:05.361138Z","steps":["trace[1447146411] 'process raft request' (duration: 141.262673ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:11.913961Z","caller":"traceutil/trace.go:171","msg":"trace[1807658020] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"176.409036ms","start":"2026-09-25T15:02:11.737522Z","end":"2026-09-25T15:02:11.913931Z","steps":["trace[1807658020] 'process raft request' (duration: 176.224342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.167637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.276682ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-25T15:02:12.167843Z","caller":"traceutil/trace.go:171","msg":"trace[835574744] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"164.927556ms","start":"2026-09-25T15:02:12.002884Z","end":"2026-09-25T15:02:12.167812Z","steps":["trace[835574744] 'read index received' (duration: 32.998681ms)","trace[835574744] 'applied index is now lower than readState.Index' (duration: 131.927375ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:02:12.167936Z","caller":"traceutil/trace.go:171","msg":"trace[1944697798] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"232.635492ms","start":"2026-09-25T15:02:11.935272Z","end":"2026-09-25T15:02:12.167907Z","steps":["trace[1944697798] 'process raft request' (duration: 100.553984ms)","trace[1944697798] 'compare' (duration: 131.13447ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:02:12.168158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.248282ms","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-25T15:02:12.168236Z","caller":"traceutil/trace.go:171","msg":"trace[176826727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"165.381655ms","start":"2026-09-25T15:02:12.002836Z","end":"2026-09-25T15:02:12.168218Z","steps":["trace[176826727] 'agreement among raft nodes before linearized reading' (duration: 165.10099ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:12.168255Z","caller":"traceutil/trace.go:171","msg":"trace[1650873553] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"227.523735ms","start":"2026-09-25T15:02:11.940721Z","end":"2026-09-25T15:02:12.168245Z","steps":["trace[1650873553] 'process raft request' (duration: 227.021865ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.16817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.13996ms","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-25T15:02:12.168366Z","caller":"traceutil/trace.go:171","msg":"trace[153455999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"165.376925ms","start":"2026-09-25T15:02:12.002958Z","end":"2026-09-25T15:02:12.168335Z","steps":["trace[153455999] 'agreement among raft nodes before linearized reading' (duration: 165.077499ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:12.523472Z","caller":"traceutil/trace.go:171","msg":"trace[1804086695] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"350.647531ms","start":"2026-09-25T15:02:12.172807Z","end":"2026-09-25T15:02:12.523455Z","steps":["trace[1804086695] 'process raft request' (duration: 350.418826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.523726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.1728Z","time spent":"350.730642ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:02:12.523728Z","caller":"traceutil/trace.go:171","msg":"trace[1072997541] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"348.905868ms","start":"2026-09-25T15:02:12.174797Z","end":"2026-09-25T15:02:12.523703Z","steps":["trace[1072997541] 'process raft request' (duration: 348.602172ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.523861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.174762Z","time spent":"349.03376ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:02:12.523964Z","caller":"traceutil/trace.go:171","msg":"trace[624304601] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"348.968709ms","start":"2026-09-25T15:02:12.174987Z","end":"2026-09-25T15:02:12.523956Z","steps":["trace[624304601] 'process raft request' (duration: 348.627613ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.52401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.174949Z","time spent":"349.036881ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:02:12.524314Z","caller":"traceutil/trace.go:171","msg":"trace[1856377789] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"348.430498ms","start":"2026-09-25T15:02:12.175868Z","end":"2026-09-25T15:02:12.524298Z","steps":["trace[1856377789] 'process raft request' (duration: 348.050292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.524677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.175858Z","time spent":"348.785235ms","remote":"127.0.0.1:53220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-25T15:02:12.52435Z","caller":"traceutil/trace.go:171","msg":"trace[467157297] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"346.870759ms","start":"2026-09-25T15:02:12.177455Z","end":"2026-09-25T15:02:12.524326Z","steps":["trace[467157297] 'process raft request' (duration: 346.764167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:12.524856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.177433Z","time spent":"347.394218ms","remote":"127.0.0.1:53398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:02:13.182754Z","caller":"traceutil/trace.go:171","msg":"trace[617687547] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"482.011846ms","start":"2026-09-25T15:02:12.700715Z","end":"2026-09-25T15:02:13.182727Z","steps":["trace[617687547] 'read index received' (duration: 481.833812ms)","trace[617687547] 'applied index is now lower than readState.Index' (duration: 177.114µs)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:02:13.182888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.157598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:02:13.182856Z","caller":"traceutil/trace.go:171","msg":"trace[598903220] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"573.891553ms","start":"2026-09-25T15:02:12.608908Z","end":"2026-09-25T15:02:13.1828Z","steps":["trace[598903220] 'process raft request' (duration: 573.671449ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:13.182925Z","caller":"traceutil/trace.go:171","msg":"trace[1940523042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"482.25006ms","start":"2026-09-25T15:02:12.700664Z","end":"2026-09-25T15:02:13.182914Z","steps":["trace[1940523042] 'agreement among raft nodes before linearized reading' (duration: 482.167179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:13.182957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.70064Z","time spent":"482.309921ms","remote":"127.0.0.1:53154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-25T15:02:13.183048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:12.608885Z","time spent":"574.058227ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T15:02:30.167446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.363284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-59m65\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-25T15:02:30.167594Z","caller":"traceutil/trace.go:171","msg":"trace[219793265] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-59m65; range_end:; response_count:1; response_revision:780; }","duration":"235.592758ms","start":"2026-09-25T15:02:29.931948Z","end":"2026-09-25T15:02:30.167541Z","steps":["trace[219793265] 'range keys from in-memory index tree' (duration: 234.882845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:03:28.497605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.264725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:03:28.497681Z","caller":"traceutil/trace.go:171","msg":"trace[1755611422] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1130; }","duration":"174.381398ms","start":"2026-09-25T15:03:28.323283Z","end":"2026-09-25T15:03:28.497664Z","steps":["trace[1755611422] 'count revisions from in-memory index tree' (duration: 174.188363ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:03:29.29748Z","caller":"traceutil/trace.go:171","msg":"trace[315156449] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"268.797514ms","start":"2026-09-25T15:03:29.028658Z","end":"2026-09-25T15:03:29.297455Z","steps":["trace[315156449] 'process raft request' (duration: 249.642217ms)","trace[315156449] 'compare' (duration: 19.043105ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:03:29.366677Z","caller":"traceutil/trace.go:171","msg":"trace[1751168869] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"323.934289ms","start":"2026-09-25T15:03:29.042717Z","end":"2026-09-25T15:03:29.366652Z","steps":["trace[1751168869] 'process raft request' (duration: 323.636813ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:03:29.366826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:03:29.042697Z","time spent":"324.05259ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:03:29.366811Z","caller":"traceutil/trace.go:171","msg":"trace[626538789] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"123.399531ms","start":"2026-09-25T15:03:29.243387Z","end":"2026-09-25T15:03:29.366786Z","steps":["trace[626538789] 'process raft request' (duration: 123.102035ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:03:30.003687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.156684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T15:03:30.003795Z","caller":"traceutil/trace.go:171","msg":"trace[1291607122] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"303.603812ms","start":"2026-09-25T15:03:29.700173Z","end":"2026-09-25T15:03:30.003777Z","steps":["trace[1291607122] 'read index received' (duration: 141.225404ms)","trace[1291607122] 'applied index is now lower than readState.Index' (duration: 162.376938ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:03:30.00388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.703564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:03:30.003916Z","caller":"traceutil/trace.go:171","msg":"trace[842742898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1137; }","duration":"303.761965ms","start":"2026-09-25T15:03:29.700134Z","end":"2026-09-25T15:03:30.003896Z","steps":["trace[842742898] 'agreement among raft nodes before linearized reading' (duration: 303.691504ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:03:30.003944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:03:29.700114Z","time spent":"303.823206ms","remote":"127.0.0.1:53154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-25T15:03:30.004235Z","caller":"traceutil/trace.go:171","msg":"trace[196550975] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"322.473963ms","start":"2026-09-25T15:03:29.681747Z","end":"2026-09-25T15:03:30.004221Z","steps":["trace[196550975] 'process raft request' (duration: 159.709138ms)","trace[196550975] 'compare' (duration: 162.045721ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:03:30.004296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:03:29.681724Z","time spent":"322.539132ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:03:44.434242Z","caller":"traceutil/trace.go:171","msg":"trace[1809009418] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"368.89738ms","start":"2026-09-25T15:03:44.065312Z","end":"2026-09-25T15:03:44.43421Z","steps":["trace[1809009418] 'process raft request' (duration: 368.685585ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:03:44.434459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:03:44.06529Z","time spent":"369.044743ms","remote":"127.0.0.1:53422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:08:16.646634Z","caller":"traceutil/trace.go:171","msg":"trace[968336353] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"109.933323ms","start":"2026-09-25T15:08:16.536664Z","end":"2026-09-25T15:08:16.646597Z","steps":["trace[968336353] 'process raft request' (duration: 35.511482ms)","trace[968336353] 'compare' (duration: 74.072435ms)"],"step_count":2}