{"level":"warn","ts":"2026-10-03T09:14:14.222475Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T09:14:14.222631Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.239: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.239:2380","--initial-cluster=instance=https://162.253.55.239:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.239:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.239: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-10-03T09:14:14.222778Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T09:14:14.222801Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.239:2380"]} {"level":"info","ts":"2026-10-03T09:14:14.222842Z","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-10-03T09:14:14.223788Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"]} {"level":"info","ts":"2026-10-03T09:14:14.223881Z","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.239:2380"],"listen-peer-urls":["https://162.253.55.239:2380"],"advertise-client-urls":["https://162.253.55.239:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.239: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-10-03T09:14:14.227543Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.689637ms"} {"level":"info","ts":"2026-10-03T09:14:14.236602Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"548b318b3528a14c","cluster-id":"8bf5e58b9331730a"} {"level":"info","ts":"2026-10-03T09:14:14.236706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T09:14:14.23673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became follower at term 0"} {"level":"info","ts":"2026-10-03T09:14:14.236743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 548b318b3528a14c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T09:14:14.236751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became follower at term 1"} {"level":"info","ts":"2026-10-03T09:14:14.236806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=(6092017394910798156)"} {"level":"warn","ts":"2026-10-03T09:14:14.242153Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T09:14:14.244059Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T09:14:14.245617Z","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-10-03T09:14:14.248605Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"548b318b3528a14c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T09:14:14.251106Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"548b318b3528a14c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T09:14:14.253755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=(6092017394910798156)"} {"level":"info","ts":"2026-10-03T09:14:14.256185Z","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-10-03T09:14:14.256251Z","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-10-03T09:14:14.25626Z","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-10-03T09:14:14.25638Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8bf5e58b9331730a","local-member-id":"548b318b3528a14c","added-peer-id":"548b318b3528a14c","added-peer-peer-urls":["https://162.253.55.239:2380"]} {"level":"info","ts":"2026-10-03T09:14:14.256897Z","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-10-03T09:14:14.257058Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"548b318b3528a14c","initial-advertise-peer-urls":["https://162.253.55.239:2380"],"listen-peer-urls":["https://162.253.55.239:2380"],"advertise-client-urls":["https://162.253.55.239:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T09:14:14.257076Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T09:14:14.257072Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.239:2380"} {"level":"info","ts":"2026-10-03T09:14:14.257148Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.239:2380"} {"level":"info","ts":"2026-10-03T09:14:14.537397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T09:14:14.537506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T09:14:14.537553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c received MsgPreVoteResp from 548b318b3528a14c at term 1"} {"level":"info","ts":"2026-10-03T09:14:14.537878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became candidate at term 2"} {"level":"info","ts":"2026-10-03T09:14:14.537911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c received MsgVoteResp from 548b318b3528a14c at term 2"} {"level":"info","ts":"2026-10-03T09:14:14.537929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became leader at term 2"} {"level":"info","ts":"2026-10-03T09:14:14.537945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 548b318b3528a14c elected leader 548b318b3528a14c at term 2"} {"level":"info","ts":"2026-10-03T09:14:14.539293Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"548b318b3528a14c","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.239:2379]}","request-path":"/0/members/548b318b3528a14c/attributes","cluster-id":"8bf5e58b9331730a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T09:14:14.539521Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T09:14:14.539729Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T09:14:14.539804Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T09:14:14.539779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:14:14.539941Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T09:14:14.540824Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8bf5e58b9331730a","local-member-id":"548b318b3528a14c","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:14:14.541041Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:14:14.541135Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T09:14:14.543382Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-03T09:14:14.54426Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.239:2379"} {"level":"warn","ts":"2026-10-03T09:14:18.648324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.338354ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:14:18.648743Z","caller":"traceutil/trace.go:171","msg":"trace[991070207] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"452.628834ms","start":"2026-10-03T09:14:18.196072Z","end":"2026-10-03T09:14:18.648701Z","steps":["trace[991070207] 'process raft request' (duration: 174.367885ms)","trace[991070207] 'compare' (duration: 277.179549ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:14:18.648938Z","caller":"traceutil/trace.go:171","msg":"trace[509389208] linearizableReadLoop","detail":"{readStateIndex:197; appliedIndex:196; }","duration":"220.743358ms","start":"2026-10-03T09:14:18.428137Z","end":"2026-10-03T09:14:18.64888Z","steps":["trace[509389208] 'read index received' (duration: 68.551µs)","trace[509389208] 'applied index is now lower than readState.Index' (duration: 220.665947ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:14:18.649079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:14:18.196057Z","time spent":"452.900672ms","remote":"127.0.0.1:46160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-03T09:14:18.649207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.073459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-03T09:14:18.649302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.14525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-03T09:14:18.649356Z","caller":"traceutil/trace.go:171","msg":"trace[992453668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:193; }","duration":"185.294233ms","start":"2026-10-03T09:14:18.464046Z","end":"2026-10-03T09:14:18.649341Z","steps":["trace[992453668] 'agreement among raft nodes before linearized reading' (duration: 185.116408ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:18.649367Z","caller":"traceutil/trace.go:171","msg":"trace[1393517970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:193; }","duration":"221.243543ms","start":"2026-10-03T09:14:18.428056Z","end":"2026-10-03T09:14:18.6493Z","steps":["trace[1393517970] 'agreement among raft nodes before linearized reading' (duration: 220.989666ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:18.832221Z","caller":"traceutil/trace.go:171","msg":"trace[1174206178] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"181.712402ms","start":"2026-10-03T09:14:18.650441Z","end":"2026-10-03T09:14:18.832154Z","steps":["trace[1174206178] 'process raft request' (duration: 139.269739ms)","trace[1174206178] 'compare' (duration: 42.263388ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:14:18.832358Z","caller":"traceutil/trace.go:171","msg":"trace[950192757] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"178.389388ms","start":"2026-10-03T09:14:18.653935Z","end":"2026-10-03T09:14:18.832325Z","steps":["trace[950192757] 'process raft request' (duration: 178.175612ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:18.832292Z","caller":"traceutil/trace.go:171","msg":"trace[1020598481] linearizableReadLoop","detail":"{readStateIndex:199; appliedIndex:198; }","duration":"180.755995ms","start":"2026-10-03T09:14:18.65151Z","end":"2026-10-03T09:14:18.832266Z","steps":["trace[1020598481] 'read index received' (duration: 138.24252ms)","trace[1020598481] 'applied index is now lower than readState.Index' (duration: 42.512035ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:14:18.832838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.228828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:14:18.833623Z","caller":"traceutil/trace.go:171","msg":"trace[255730131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:196; }","duration":"182.138354ms","start":"2026-10-03T09:14:18.651463Z","end":"2026-10-03T09:14:18.833601Z","steps":["trace[255730131] 'agreement among raft nodes before linearized reading' (duration: 181.106105ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.239395Z","caller":"traceutil/trace.go:171","msg":"trace[1787260358] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"216.936952ms","start":"2026-10-03T09:14:51.022425Z","end":"2026-10-03T09:14:51.239361Z","steps":["trace[1787260358] 'process raft request' (duration: 216.757157ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.239502Z","caller":"traceutil/trace.go:171","msg":"trace[753995936] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"226.916285ms","start":"2026-10-03T09:14:51.012541Z","end":"2026-10-03T09:14:51.239458Z","steps":["trace[753995936] 'process raft request' (duration: 224.98529ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.239631Z","caller":"traceutil/trace.go:171","msg":"trace[1972085166] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"242.512007ms","start":"2026-10-03T09:14:50.996985Z","end":"2026-10-03T09:14:51.239497Z","steps":["trace[1972085166] 'process raft request' (duration: 240.408147ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.24008Z","caller":"traceutil/trace.go:171","msg":"trace[1771996416] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"227.343096ms","start":"2026-10-03T09:14:51.012597Z","end":"2026-10-03T09:14:51.23994Z","steps":["trace[1771996416] 'process raft request' (duration: 225.01409ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.240352Z","caller":"traceutil/trace.go:171","msg":"trace[213347076] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"234.146849ms","start":"2026-10-03T09:14:51.006113Z","end":"2026-10-03T09:14:51.24026Z","steps":["trace[213347076] 'process raft request' (duration: 231.327329ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.240611Z","caller":"traceutil/trace.go:171","msg":"trace[580085452] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"234.312294ms","start":"2026-10-03T09:14:51.006224Z","end":"2026-10-03T09:14:51.240536Z","steps":["trace[580085452] 'process raft request' (duration: 231.257198ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.241028Z","caller":"traceutil/trace.go:171","msg":"trace[2141923052] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"247.716574ms","start":"2026-10-03T09:14:50.993162Z","end":"2026-10-03T09:14:51.240879Z","steps":["trace[2141923052] 'process raft request' (duration: 223.349593ms)","trace[2141923052] 'compare' (duration: 20.744878ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:14:51.241119Z","caller":"traceutil/trace.go:171","msg":"trace[929735965] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"222.012506ms","start":"2026-10-03T09:14:51.019068Z","end":"2026-10-03T09:14:51.241081Z","steps":["trace[929735965] 'process raft request' (duration: 218.581278ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.241379Z","caller":"traceutil/trace.go:171","msg":"trace[297555560] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"222.149569ms","start":"2026-10-03T09:14:51.019065Z","end":"2026-10-03T09:14:51.241215Z","steps":["trace[297555560] 'process raft request' (duration: 218.64662ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.241179Z","caller":"traceutil/trace.go:171","msg":"trace[1005815915] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"221.82865ms","start":"2026-10-03T09:14:51.019124Z","end":"2026-10-03T09:14:51.240953Z","steps":["trace[1005815915] 'process raft request' (duration: 218.63789ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.242404Z","caller":"traceutil/trace.go:171","msg":"trace[2095985450] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:540; }","duration":"245.336447ms","start":"2026-10-03T09:14:50.99701Z","end":"2026-10-03T09:14:51.242347Z","steps":["trace[2095985450] 'read index received' (duration: 74.592885ms)","trace[2095985450] 'applied index is now lower than readState.Index' (duration: 170.742242ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:14:51.242605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.572903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-03T09:14:51.242651Z","caller":"traceutil/trace.go:171","msg":"trace[1874595317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:533; }","duration":"245.643806ms","start":"2026-10-03T09:14:50.996983Z","end":"2026-10-03T09:14:51.242627Z","steps":["trace[1874595317] 'agreement among raft nodes before linearized reading' (duration: 245.45795ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.242851Z","caller":"traceutil/trace.go:171","msg":"trace[523733086] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"196.762549ms","start":"2026-10-03T09:14:51.046063Z","end":"2026-10-03T09:14:51.242826Z","steps":["trace[523733086] 'process raft request' (duration: 196.025358ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.24305Z","caller":"traceutil/trace.go:171","msg":"trace[1908860375] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"184.889613ms","start":"2026-10-03T09:14:51.05814Z","end":"2026-10-03T09:14:51.243029Z","steps":["trace[1908860375] 'process raft request' (duration: 184.118271ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.374342Z","caller":"traceutil/trace.go:171","msg":"trace[1944894587] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"298.077972ms","start":"2026-10-03T09:14:51.076222Z","end":"2026-10-03T09:14:51.3743Z","steps":["trace[1944894587] 'process raft request' (duration: 282.035957ms)","trace[1944894587] 'compare' (duration: 15.762597ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:14:51.3745Z","caller":"traceutil/trace.go:171","msg":"trace[1208615729] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"296.417695ms","start":"2026-10-03T09:14:51.078059Z","end":"2026-10-03T09:14:51.374476Z","steps":["trace[1208615729] 'process raft request' (duration: 296.196769ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.374775Z","caller":"traceutil/trace.go:171","msg":"trace[1776837126] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"297.130535ms","start":"2026-10-03T09:14:51.077636Z","end":"2026-10-03T09:14:51.374766Z","steps":["trace[1776837126] 'process raft request' (duration: 296.558309ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.374881Z","caller":"traceutil/trace.go:171","msg":"trace[297420444] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"124.642464ms","start":"2026-10-03T09:14:51.25023Z","end":"2026-10-03T09:14:51.374873Z","steps":["trace[297420444] 'process raft request' (duration: 124.470549ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375002Z","caller":"traceutil/trace.go:171","msg":"trace[572227014] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"196.288426ms","start":"2026-10-03T09:14:51.178705Z","end":"2026-10-03T09:14:51.374994Z","steps":["trace[572227014] 'process raft request' (duration: 195.689559ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375131Z","caller":"traceutil/trace.go:171","msg":"trace[1596049245] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"111.702137ms","start":"2026-10-03T09:14:51.263383Z","end":"2026-10-03T09:14:51.375085Z","steps":["trace[1596049245] 'process raft request' (duration: 111.624295ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375294Z","caller":"traceutil/trace.go:171","msg":"trace[1054587696] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"108.098105ms","start":"2026-10-03T09:14:51.267183Z","end":"2026-10-03T09:14:51.375281Z","steps":["trace[1054587696] 'process raft request' (duration: 107.873128ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375451Z","caller":"traceutil/trace.go:171","msg":"trace[1866144499] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"108.141166ms","start":"2026-10-03T09:14:51.267298Z","end":"2026-10-03T09:14:51.37544Z","steps":["trace[1866144499] 'process raft request' (duration: 107.904589ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375486Z","caller":"traceutil/trace.go:171","msg":"trace[1909969436] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"117.889632ms","start":"2026-10-03T09:14:51.257588Z","end":"2026-10-03T09:14:51.375477Z","steps":["trace[1909969436] 'process raft request' (duration: 117.233174ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375453Z","caller":"traceutil/trace.go:171","msg":"trace[2086336187] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"117.864022ms","start":"2026-10-03T09:14:51.257533Z","end":"2026-10-03T09:14:51.375397Z","steps":["trace[2086336187] 'process raft request' (duration: 117.252035ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375561Z","caller":"traceutil/trace.go:171","msg":"trace[423760505] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"116.193014ms","start":"2026-10-03T09:14:51.259361Z","end":"2026-10-03T09:14:51.375554Z","steps":["trace[423760505] 'process raft request' (duration: 115.487424ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:51.375635Z","caller":"traceutil/trace.go:171","msg":"trace[1963384528] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"115.062152ms","start":"2026-10-03T09:14:51.260561Z","end":"2026-10-03T09:14:51.375623Z","steps":["trace[1963384528] 'process raft request' (duration: 114.316181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:14:57.019073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.253762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T09:14:57.01926Z","caller":"traceutil/trace.go:171","msg":"trace[481074487] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"120.94553ms","start":"2026-10-03T09:14:56.898298Z","end":"2026-10-03T09:14:57.019243Z","steps":["trace[481074487] 'read index received' (duration: 100.343185ms)","trace[481074487] 'applied index is now lower than readState.Index' (duration: 20.601495ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:14:57.019597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.30146ms","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-10-03T09:14:57.01964Z","caller":"traceutil/trace.go:171","msg":"trace[977370114] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"178.009778ms","start":"2026-10-03T09:14:56.841621Z","end":"2026-10-03T09:14:57.019631Z","steps":["trace[977370114] 'process raft request' (duration: 177.573015ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:57.01964Z","caller":"traceutil/trace.go:171","msg":"trace[814938131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"121.368582ms","start":"2026-10-03T09:14:56.898259Z","end":"2026-10-03T09:14:57.019627Z","steps":["trace[814938131] 'agreement among raft nodes before linearized reading' (duration: 121.101644ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:57.019572Z","caller":"traceutil/trace.go:171","msg":"trace[1518733776] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"202.909604ms","start":"2026-10-03T09:14:56.816631Z","end":"2026-10-03T09:14:57.019541Z","steps":["trace[1518733776] 'process raft request' (duration: 46.989663ms)","trace[1518733776] 'compare' (duration: 155.139909ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:14:57.514576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.576406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:14:57.514668Z","caller":"traceutil/trace.go:171","msg":"trace[366550833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"383.725721ms","start":"2026-10-03T09:14:57.130921Z","end":"2026-10-03T09:14:57.514647Z","steps":["trace[366550833] 'range keys from in-memory index tree' (duration: 383.479203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:14:57.514707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.953161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-03T09:14:57.514735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:14:57.130902Z","time spent":"383.824013ms","remote":"127.0.0.1:45884","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-10-03T09:14:57.514785Z","caller":"traceutil/trace.go:171","msg":"trace[12246492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"114.075044ms","start":"2026-10-03T09:14:57.400689Z","end":"2026-10-03T09:14:57.514764Z","steps":["trace[12246492] 'range keys from in-memory index tree' (duration: 113.696965ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:14:57.514779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.773223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-03T09:14:57.514867Z","caller":"traceutil/trace.go:171","msg":"trace[1628744212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"243.890446ms","start":"2026-10-03T09:14:57.270952Z","end":"2026-10-03T09:14:57.514842Z","steps":["trace[1628744212] 'range keys from in-memory index tree' (duration: 243.592637ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:14:58.861878Z","caller":"traceutil/trace.go:171","msg":"trace[1779546769] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"115.406812ms","start":"2026-10-03T09:14:58.746434Z","end":"2026-10-03T09:14:58.861841Z","steps":["trace[1779546769] 'process raft request' (duration: 115.261318ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:11.720489Z","caller":"traceutil/trace.go:171","msg":"trace[2137936306] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"113.74709ms","start":"2026-10-03T09:15:11.606723Z","end":"2026-10-03T09:15:11.72047Z","steps":["trace[2137936306] 'process raft request' (duration: 113.597766ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:11.720672Z","caller":"traceutil/trace.go:171","msg":"trace[787594896] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"113.901104ms","start":"2026-10-03T09:15:11.606752Z","end":"2026-10-03T09:15:11.720653Z","steps":["trace[787594896] 'process raft request' (duration: 113.676168ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:11.762824Z","caller":"traceutil/trace.go:171","msg":"trace[524872617] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"115.127259ms","start":"2026-10-03T09:15:11.647666Z","end":"2026-10-03T09:15:11.762793Z","steps":["trace[524872617] 'process raft request' (duration: 113.277037ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:11.955422Z","caller":"traceutil/trace.go:171","msg":"trace[330894722] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"184.897138ms","start":"2026-10-03T09:15:11.770504Z","end":"2026-10-03T09:15:11.955401Z","steps":["trace[330894722] 'process raft request' (duration: 184.764884ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:52.029413Z","caller":"traceutil/trace.go:171","msg":"trace[1097060649] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"115.771517ms","start":"2026-10-03T09:15:51.913622Z","end":"2026-10-03T09:15:52.029393Z","steps":["trace[1097060649] 'read index received' (duration: 115.677075ms)","trace[1097060649] 'applied index is now lower than readState.Index' (duration: 93.512µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:15:52.029458Z","caller":"traceutil/trace.go:171","msg":"trace[519576137] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"118.504155ms","start":"2026-10-03T09:15:51.910927Z","end":"2026-10-03T09:15:52.029432Z","steps":["trace[519576137] 'process raft request' (duration: 118.32999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:15:52.029567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.928902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-03T09:15:52.029597Z","caller":"traceutil/trace.go:171","msg":"trace[1653171710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1075; }","duration":"115.991304ms","start":"2026-10-03T09:15:51.913597Z","end":"2026-10-03T09:15:52.029588Z","steps":["trace[1653171710] 'agreement among raft nodes before linearized reading' (duration: 115.873711ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:15:52.20787Z","caller":"traceutil/trace.go:171","msg":"trace[797029003] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"174.862516ms","start":"2026-10-03T09:15:52.032982Z","end":"2026-10-03T09:15:52.207844Z","steps":["trace[797029003] 'process raft request' (duration: 173.089406ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:16:08.827069Z","caller":"traceutil/trace.go:171","msg":"trace[2089342051] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"152.191405ms","start":"2026-10-03T09:16:08.67484Z","end":"2026-10-03T09:16:08.827032Z","steps":["trace[2089342051] 'process raft request' (duration: 151.988919ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:16:09.104256Z","caller":"traceutil/trace.go:171","msg":"trace[1228733728] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"240.467906ms","start":"2026-10-03T09:16:08.863735Z","end":"2026-10-03T09:16:09.104203Z","steps":["trace[1228733728] 'process raft request' (duration: 151.695941ms)","trace[1228733728] 'compare' (duration: 88.627751ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:16:09.135496Z","caller":"traceutil/trace.go:171","msg":"trace[408369888] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1191; }","duration":"194.731835ms","start":"2026-10-03T09:16:08.94074Z","end":"2026-10-03T09:16:09.135472Z","steps":["trace[408369888] 'read index received' (duration: 74.689948ms)","trace[408369888] 'applied index is now lower than readState.Index' (duration: 120.040937ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T09:16:09.135634Z","caller":"traceutil/trace.go:171","msg":"trace[665445422] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"201.082465ms","start":"2026-10-03T09:16:08.934542Z","end":"2026-10-03T09:16:09.135625Z","steps":["trace[665445422] 'process raft request' (duration: 200.802987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:16:09.135968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.211499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-7547z\" ","response":"range_response_count:1 size:11061"} {"level":"info","ts":"2026-10-03T09:16:09.136005Z","caller":"traceutil/trace.go:171","msg":"trace[1498256050] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-7547z; range_end:; response_count:1; response_revision:1146; }","duration":"195.292111ms","start":"2026-10-03T09:16:08.940704Z","end":"2026-10-03T09:16:09.135996Z","steps":["trace[1498256050] 'agreement among raft nodes before linearized reading' (duration: 195.155987ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:16:10.252876Z","caller":"traceutil/trace.go:171","msg":"trace[524879641] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1201; }","duration":"122.155418ms","start":"2026-10-03T09:16:10.130698Z","end":"2026-10-03T09:16:10.252853Z","steps":["trace[524879641] 'read index received' (duration: 121.977893ms)","trace[524879641] 'applied index is now lower than readState.Index' (duration: 176.645µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T09:16:10.253002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.297301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T09:16:10.253032Z","caller":"traceutil/trace.go:171","msg":"trace[1185507083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1155; }","duration":"122.382805ms","start":"2026-10-03T09:16:10.13064Z","end":"2026-10-03T09:16:10.253022Z","steps":["trace[1185507083] 'agreement among raft nodes before linearized reading' (duration: 122.297632ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:16:10.253041Z","caller":"traceutil/trace.go:171","msg":"trace[1514623094] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"152.149954ms","start":"2026-10-03T09:16:10.100854Z","end":"2026-10-03T09:16:10.253003Z","steps":["trace[1514623094] 'process raft request' (duration: 151.841775ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:16:22.482287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.522228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-03T09:16:22.482374Z","caller":"traceutil/trace.go:171","msg":"trace[1404242332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1242; }","duration":"101.655472ms","start":"2026-10-03T09:16:22.380697Z","end":"2026-10-03T09:16:22.482353Z","steps":["trace[1404242332] 'range keys from in-memory index tree' (duration: 101.20132ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:16:22.651531Z","caller":"traceutil/trace.go:171","msg":"trace[1731596794] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"164.631076ms","start":"2026-10-03T09:16:22.486801Z","end":"2026-10-03T09:16:22.651432Z","steps":["trace[1731596794] 'process raft request' (duration: 163.994928ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:16:22.860679Z","caller":"traceutil/trace.go:171","msg":"trace[1086167429] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"320.989008ms","start":"2026-10-03T09:16:22.539658Z","end":"2026-10-03T09:16:22.860647Z","steps":["trace[1086167429] 'process raft request' (duration: 320.735861ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T09:16:22.860888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T09:16:22.539631Z","time spent":"321.128772ms","remote":"127.0.0.1:46006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6758,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T09:21:00.855496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.953399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-03T09:21:00.855519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.412165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-03T09:21:00.855586Z","caller":"traceutil/trace.go:171","msg":"trace[784379881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2546; }","duration":"101.078503ms","start":"2026-10-03T09:21:00.75449Z","end":"2026-10-03T09:21:00.855568Z","steps":["trace[784379881] 'range keys from in-memory index tree' (duration: 100.759904ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T09:21:00.855603Z","caller":"traceutil/trace.go:171","msg":"trace[612436585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2546; }","duration":"105.542908ms","start":"2026-10-03T09:21:00.750039Z","end":"2026-10-03T09:21:00.855582Z","steps":["trace[612436585] 'range keys from in-memory index tree' (duration: 105.206618ms)"],"step_count":1}