{"level":"warn","ts":"2026-09-07T08:27:15.866249Z","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-07T08:27:15.866336Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.76: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.76:2380","--initial-cluster=instance=https://162.253.55.76:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.76:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.76: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-07T08:27:15.866412Z","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-07T08:27:15.866431Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-09-07T08:27:15.866499Z","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-07T08:27:15.867168Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"]} {"level":"info","ts":"2026-09-07T08:27:15.867262Z","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.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.76: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-07T08:27:15.876273Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.599835ms"} {"level":"info","ts":"2026-09-07T08:27:15.885115Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30ad0c2b6ecdd25e","cluster-id":"855d190e6ef0a61f"} {"level":"info","ts":"2026-09-07T08:27:15.885259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T08:27:15.885292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 0"} {"level":"info","ts":"2026-09-07T08:27:15.885313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30ad0c2b6ecdd25e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T08:27:15.885337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 1"} {"level":"info","ts":"2026-09-07T08:27:15.885396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"warn","ts":"2026-09-07T08:27:15.892112Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T08:27:15.893775Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T08:27:15.895928Z","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-07T08:27:15.897982Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30ad0c2b6ecdd25e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T08:27:15.903665Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30ad0c2b6ecdd25e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T08:27:15.904722Z","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-07T08:27:15.904791Z","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-07T08:27:15.904783Z","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-07T08:27:15.904826Z","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-07T08:27:15.904991Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30ad0c2b6ecdd25e","initial-advertise-peer-urls":["https://162.253.55.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T08:27:15.905014Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-09-07T08:27:15.905042Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T08:27:15.905043Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-09-07T08:27:15.906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"info","ts":"2026-09-07T08:27:15.906086Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","added-peer-id":"30ad0c2b6ecdd25e","added-peer-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-09-07T08:27:16.286566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T08:27:16.286648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T08:27:16.286665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgPreVoteResp from 30ad0c2b6ecdd25e at term 1"} {"level":"info","ts":"2026-09-07T08:27:16.286692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became candidate at term 2"} {"level":"info","ts":"2026-09-07T08:27:16.286699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgVoteResp from 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-09-07T08:27:16.286708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became leader at term 2"} {"level":"info","ts":"2026-09-07T08:27:16.286716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30ad0c2b6ecdd25e elected leader 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-09-07T08:27:16.305634Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30ad0c2b6ecdd25e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.76:2379]}","request-path":"/0/members/30ad0c2b6ecdd25e/attributes","cluster-id":"855d190e6ef0a61f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T08:27:16.305785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T08:27:16.305925Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T08:27:16.306267Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:27:16.306391Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T08:27:16.306409Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T08:27:16.308105Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:27:16.308195Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:27:16.308465Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T08:27:16.308577Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:27:16.317141Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.76:2379"} {"level":"info","ts":"2026-09-07T08:27:17.952374Z","caller":"traceutil/trace.go:171","msg":"trace[493425822] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"228.086735ms","start":"2026-09-07T08:27:17.724269Z","end":"2026-09-07T08:27:17.952356Z","steps":["trace[493425822] 'process raft request' (duration: 227.889841ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.96682Z","caller":"traceutil/trace.go:171","msg":"trace[96217735] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"242.434239ms","start":"2026-09-07T08:27:17.724355Z","end":"2026-09-07T08:27:17.966789Z","steps":["trace[96217735] 'process raft request' (duration: 242.265425ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.96692Z","caller":"traceutil/trace.go:171","msg":"trace[1194951795] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:4; }","duration":"241.441678ms","start":"2026-09-07T08:27:17.725458Z","end":"2026-09-07T08:27:17.9669Z","steps":["trace[1194951795] 'read index received' (duration: 226.812868ms)","trace[1194951795] 'applied index is now lower than readState.Index' (duration: 14.628ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:27:17.967069Z","caller":"traceutil/trace.go:171","msg":"trace[250038584] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"242.096162ms","start":"2026-09-07T08:27:17.724943Z","end":"2026-09-07T08:27:17.967039Z","steps":["trace[250038584] 'process raft request' (duration: 241.796856ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.967208Z","caller":"traceutil/trace.go:171","msg":"trace[1912372557] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"170.775509ms","start":"2026-09-07T08:27:17.796416Z","end":"2026-09-07T08:27:17.967192Z","steps":["trace[1912372557] 'process raft request' (duration: 170.438892ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.967346Z","caller":"traceutil/trace.go:171","msg":"trace[2026692473] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"163.766831ms","start":"2026-09-07T08:27:17.803567Z","end":"2026-09-07T08:27:17.967333Z","steps":["trace[2026692473] 'process raft request' (duration: 163.308352ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.96737Z","caller":"traceutil/trace.go:171","msg":"trace[305825668] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"173.619061ms","start":"2026-09-07T08:27:17.793722Z","end":"2026-09-07T08:27:17.967341Z","steps":["trace[305825668] 'process raft request' (duration: 173.041958ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.967441Z","caller":"traceutil/trace.go:171","msg":"trace[979924769] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"171.448724ms","start":"2026-09-07T08:27:17.795978Z","end":"2026-09-07T08:27:17.967427Z","steps":["trace[979924769] 'process raft request' (duration: 170.861132ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.967497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.02315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.967554Z","caller":"traceutil/trace.go:171","msg":"trace[496692098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"242.108322ms","start":"2026-09-07T08:27:17.725436Z","end":"2026-09-07T08:27:17.967545Z","steps":["trace[496692098] 'agreement among raft nodes before linearized reading' (duration: 241.960929ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.967601Z","caller":"traceutil/trace.go:171","msg":"trace[1892700811] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"171.705769ms","start":"2026-09-07T08:27:17.795849Z","end":"2026-09-07T08:27:17.967555Z","steps":["trace[1892700811] 'process raft request' (duration: 170.952263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.967686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.155473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.967712Z","caller":"traceutil/trace.go:171","msg":"trace[273816848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"242.209064ms","start":"2026-09-07T08:27:17.725497Z","end":"2026-09-07T08:27:17.967706Z","steps":["trace[273816848] 'agreement among raft nodes before linearized reading' (duration: 242.153033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.96773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.898015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.967733Z","caller":"traceutil/trace.go:171","msg":"trace[630356740] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"171.72732ms","start":"2026-09-07T08:27:17.795996Z","end":"2026-09-07T08:27:17.967724Z","steps":["trace[630356740] 'process raft request' (duration: 170.827251ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.967784Z","caller":"traceutil/trace.go:171","msg":"trace[351520190] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"173.008887ms","start":"2026-09-07T08:27:17.794752Z","end":"2026-09-07T08:27:17.967761Z","steps":["trace[351520190] 'agreement among raft nodes before linearized reading' (duration: 172.948976ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.967799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.264765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.76\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-07T08:27:17.967803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.662128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.967819Z","caller":"traceutil/trace.go:171","msg":"trace[47557916] range","detail":"{range_begin:/registry/masterleases/162.253.55.76; range_end:; response_count:0; response_revision:11; }","duration":"175.340137ms","start":"2026-09-07T08:27:17.792473Z","end":"2026-09-07T08:27:17.967813Z","steps":["trace[47557916] 'agreement among raft nodes before linearized reading' (duration: 175.309756ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.967859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.082719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.967885Z","caller":"traceutil/trace.go:171","msg":"trace[1313023923] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"232.11381ms","start":"2026-09-07T08:27:17.735765Z","end":"2026-09-07T08:27:17.967879Z","steps":["trace[1313023923] 'agreement among raft nodes before linearized reading' (duration: 232.046119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.967919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.989377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.967951Z","caller":"traceutil/trace.go:171","msg":"trace[1830344159] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"173.080438ms","start":"2026-09-07T08:27:17.794861Z","end":"2026-09-07T08:27:17.967942Z","steps":["trace[1830344159] 'agreement among raft nodes before linearized reading' (duration: 173.036997ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.96784Z","caller":"traceutil/trace.go:171","msg":"trace[1643858442] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"121.770361ms","start":"2026-09-07T08:27:17.846059Z","end":"2026-09-07T08:27:17.96783Z","steps":["trace[1643858442] 'agreement among raft nodes before linearized reading' (duration: 121.670569ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:27:17.968071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.805534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-07T08:27:17.968154Z","caller":"traceutil/trace.go:171","msg":"trace[2058783471] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"198.904017ms","start":"2026-09-07T08:27:17.769241Z","end":"2026-09-07T08:27:17.968145Z","steps":["trace[2058783471] 'agreement among raft nodes before linearized reading' (duration: 198.809735ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:17.968221Z","caller":"traceutil/trace.go:171","msg":"trace[23006217] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"172.335793ms","start":"2026-09-07T08:27:17.795854Z","end":"2026-09-07T08:27:17.96819Z","steps":["trace[23006217] 'process raft request' (duration: 170.930673ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:19.35126Z","caller":"traceutil/trace.go:171","msg":"trace[2109787168] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"110.669184ms","start":"2026-09-07T08:27:19.240546Z","end":"2026-09-07T08:27:19.351215Z","steps":["trace[2109787168] 'process raft request' (duration: 35.962012ms)","trace[2109787168] 'compare' (duration: 74.527549ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:27:24.589094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.059407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-07T08:27:24.589186Z","caller":"traceutil/trace.go:171","msg":"trace[1678062133] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:333; }","duration":"159.17318ms","start":"2026-09-07T08:27:24.429994Z","end":"2026-09-07T08:27:24.589167Z","steps":["trace[1678062133] 'range keys from in-memory index tree' (duration: 158.903485ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:24.729319Z","caller":"traceutil/trace.go:171","msg":"trace[1934729808] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"136.489161ms","start":"2026-09-07T08:27:24.592797Z","end":"2026-09-07T08:27:24.729286Z","steps":["trace[1934729808] 'process raft request' (duration: 136.303897ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:25.097483Z","caller":"traceutil/trace.go:171","msg":"trace[592569679] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"344.67225ms","start":"2026-09-07T08:27:24.75277Z","end":"2026-09-07T08:27:25.097442Z","steps":["trace[592569679] 'process raft request' (duration: 331.393153ms)","trace[592569679] 'compare' (duration: 13.136764ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:27:25.102705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:27:24.752749Z","time spent":"344.817022ms","remote":"127.0.0.1:35022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T08:27:25.268493Z","caller":"traceutil/trace.go:171","msg":"trace[913116709] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"153.807891ms","start":"2026-09-07T08:27:25.114657Z","end":"2026-09-07T08:27:25.268465Z","steps":["trace[913116709] 'process raft request' (duration: 153.2745ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.931128Z","caller":"traceutil/trace.go:171","msg":"trace[1540778380] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"159.052877ms","start":"2026-09-07T08:27:54.772056Z","end":"2026-09-07T08:27:54.931109Z","steps":["trace[1540778380] 'process raft request' (duration: 158.934485ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.940981Z","caller":"traceutil/trace.go:171","msg":"trace[160535560] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"165.007639ms","start":"2026-09-07T08:27:54.775946Z","end":"2026-09-07T08:27:54.940954Z","steps":["trace[160535560] 'process raft request' (duration: 164.863566ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.94112Z","caller":"traceutil/trace.go:171","msg":"trace[932025701] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"150.275356ms","start":"2026-09-07T08:27:54.79084Z","end":"2026-09-07T08:27:54.941115Z","steps":["trace[932025701] 'process raft request' (duration: 150.140324ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941162Z","caller":"traceutil/trace.go:171","msg":"trace[1979426273] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"146.498942ms","start":"2026-09-07T08:27:54.794652Z","end":"2026-09-07T08:27:54.941151Z","steps":["trace[1979426273] 'process raft request' (duration: 146.37915ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941017Z","caller":"traceutil/trace.go:171","msg":"trace[967185734] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"155.560747ms","start":"2026-09-07T08:27:54.785438Z","end":"2026-09-07T08:27:54.940999Z","steps":["trace[967185734] 'process raft request' (duration: 155.421025ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941071Z","caller":"traceutil/trace.go:171","msg":"trace[650032532] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"154.578151ms","start":"2026-09-07T08:27:54.786487Z","end":"2026-09-07T08:27:54.941065Z","steps":["trace[650032532] 'process raft request' (duration: 154.416218ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941342Z","caller":"traceutil/trace.go:171","msg":"trace[1588645223] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"144.320855ms","start":"2026-09-07T08:27:54.797006Z","end":"2026-09-07T08:27:54.941327Z","steps":["trace[1588645223] 'process raft request' (duration: 144.069531ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941098Z","caller":"traceutil/trace.go:171","msg":"trace[748669419] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"150.286227ms","start":"2026-09-07T08:27:54.790806Z","end":"2026-09-07T08:27:54.941093Z","steps":["trace[748669419] 'process raft request' (duration: 150.134824ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941446Z","caller":"traceutil/trace.go:171","msg":"trace[1536662407] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"114.844082ms","start":"2026-09-07T08:27:54.82657Z","end":"2026-09-07T08:27:54.941414Z","steps":["trace[1536662407] 'process raft request' (duration: 114.75068ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941485Z","caller":"traceutil/trace.go:171","msg":"trace[1317976957] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"139.489552ms","start":"2026-09-07T08:27:54.801962Z","end":"2026-09-07T08:27:54.941452Z","steps":["trace[1317976957] 'process raft request' (duration: 139.193447ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:27:54.941684Z","caller":"traceutil/trace.go:171","msg":"trace[1487029751] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"165.08473ms","start":"2026-09-07T08:27:54.775796Z","end":"2026-09-07T08:27:54.94088Z","steps":["trace[1487029751] 'process raft request' (duration: 164.881977ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:28:01.253597Z","caller":"traceutil/trace.go:171","msg":"trace[1865620549] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"309.19021ms","start":"2026-09-07T08:28:00.944346Z","end":"2026-09-07T08:28:01.253536Z","steps":["trace[1865620549] 'process raft request' (duration: 307.775907ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:01.253986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:28:00.944314Z","time spent":"309.355773ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:28:01.509167Z","caller":"traceutil/trace.go:171","msg":"trace[1924508226] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"191.516289ms","start":"2026-09-07T08:28:01.317612Z","end":"2026-09-07T08:28:01.509128Z","steps":["trace[1924508226] 'process raft request' (duration: 116.450247ms)","trace[1924508226] 'compare' (duration: 74.890989ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:28:02.125538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.576874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:28:02.125651Z","caller":"traceutil/trace.go:171","msg":"trace[1430486227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"216.739357ms","start":"2026-09-07T08:28:01.908886Z","end":"2026-09-07T08:28:02.125625Z","steps":["trace[1430486227] 'range keys from in-memory index tree' (duration: 216.483313ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:02.125843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.147987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-07T08:28:02.125931Z","caller":"traceutil/trace.go:171","msg":"trace[303430425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"387.269509ms","start":"2026-09-07T08:28:01.738643Z","end":"2026-09-07T08:28:02.125913Z","steps":["trace[303430425] 'range keys from in-memory index tree' (duration: 386.941553ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:02.125973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:28:01.738625Z","time spent":"387.33471ms","remote":"127.0.0.1:35084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-07T08:28:02.126417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.691552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4m9wd\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-07T08:28:02.126484Z","caller":"traceutil/trace.go:171","msg":"trace[1477603597] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4m9wd; range_end:; response_count:1; response_revision:632; }","duration":"449.788534ms","start":"2026-09-07T08:28:01.676677Z","end":"2026-09-07T08:28:02.126465Z","steps":["trace[1477603597] 'range keys from in-memory index tree' (duration: 449.529669ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:02.12689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:28:01.676659Z","time spent":"450.216661ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-4m9wd\" "} {"level":"info","ts":"2026-09-07T08:28:02.133388Z","caller":"traceutil/trace.go:171","msg":"trace[510457131] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"210.573955ms","start":"2026-09-07T08:28:01.922788Z","end":"2026-09-07T08:28:02.133362Z","steps":["trace[510457131] 'process raft request' (duration: 209.812142ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:28:16.480617Z","caller":"traceutil/trace.go:171","msg":"trace[2062534055] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"146.944427ms","start":"2026-09-07T08:28:16.333646Z","end":"2026-09-07T08:28:16.48059Z","steps":["trace[2062534055] 'read index received' (duration: 144.747183ms)","trace[2062534055] 'applied index is now lower than readState.Index' (duration: 2.195864ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:28:16.480778Z","caller":"traceutil/trace.go:171","msg":"trace[728538481] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"270.49066ms","start":"2026-09-07T08:28:16.21026Z","end":"2026-09-07T08:28:16.48075Z","steps":["trace[728538481] 'process raft request' (duration: 268.226025ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:16.480842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.176539ms","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-07T08:28:16.48087Z","caller":"traceutil/trace.go:171","msg":"trace[644400143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"125.240919ms","start":"2026-09-07T08:28:16.355621Z","end":"2026-09-07T08:28:16.480862Z","steps":["trace[644400143] 'agreement among raft nodes before linearized reading' (duration: 125.106587ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:16.480947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.271942ms","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-07T08:28:16.481046Z","caller":"traceutil/trace.go:171","msg":"trace[902704020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"147.428005ms","start":"2026-09-07T08:28:16.333596Z","end":"2026-09-07T08:28:16.481024Z","steps":["trace[902704020] 'agreement among raft nodes before linearized reading' (duration: 147.12556ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:28:19.147817Z","caller":"traceutil/trace.go:171","msg":"trace[943703553] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:835; }","duration":"240.700613ms","start":"2026-09-07T08:28:18.907023Z","end":"2026-09-07T08:28:19.147724Z","steps":["trace[943703553] 'read index received' (duration: 240.251236ms)","trace[943703553] 'applied index is now lower than readState.Index' (duration: 447.937µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:28:19.148034Z","caller":"traceutil/trace.go:171","msg":"trace[637792060] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"369.901109ms","start":"2026-09-07T08:28:18.778106Z","end":"2026-09-07T08:28:19.148007Z","steps":["trace[637792060] 'process raft request' (duration: 369.30018ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:19.148063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.995097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:28:19.148119Z","caller":"traceutil/trace.go:171","msg":"trace[1297501900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"241.130859ms","start":"2026-09-07T08:28:18.906971Z","end":"2026-09-07T08:28:19.148102Z","steps":["trace[1297501900] 'agreement among raft nodes before linearized reading' (duration: 240.949776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:28:19.148242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:28:18.778092Z","time spent":"370.011791ms","remote":"127.0.0.1:35006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}