{"level":"warn","ts":"2026-09-22T03:42:04.722601Z","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-22T03:42:04.722689Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.104: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.104:2380","--initial-cluster=instance=https://162.253.55.104:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.104:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.104: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-22T03:42:04.722749Z","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-22T03:42:04.722757Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.104:2380"]} {"level":"info","ts":"2026-09-22T03:42:04.722779Z","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-22T03:42:04.723351Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"]} {"level":"info","ts":"2026-09-22T03:42:04.723592Z","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.104:2380"],"listen-peer-urls":["https://162.253.55.104:2380"],"advertise-client-urls":["https://162.253.55.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.104: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-22T03:42:04.728613Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.819851ms"} {"level":"info","ts":"2026-09-22T03:42:04.740457Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8572cc3a5351216d","cluster-id":"c1a156b8f69e6a79"} {"level":"info","ts":"2026-09-22T03:42:04.740545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T03:42:04.740574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became follower at term 0"} {"level":"info","ts":"2026-09-22T03:42:04.740597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8572cc3a5351216d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T03:42:04.740613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became follower at term 1"} {"level":"info","ts":"2026-09-22T03:42:04.740653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=(9615972705267425645)"} {"level":"warn","ts":"2026-09-22T03:42:04.759023Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T03:42:04.761767Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T03:42:04.762978Z","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-22T03:42:04.765338Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8572cc3a5351216d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T03:42:04.766466Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8572cc3a5351216d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T03:42:04.766502Z","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-22T03:42:04.766603Z","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-22T03:42:04.766635Z","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-22T03:42:04.769574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=(9615972705267425645)"} {"level":"info","ts":"2026-09-22T03:42:04.769764Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c1a156b8f69e6a79","local-member-id":"8572cc3a5351216d","added-peer-id":"8572cc3a5351216d","added-peer-peer-urls":["https://162.253.55.104:2380"]} {"level":"info","ts":"2026-09-22T03:42:04.770969Z","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-22T03:42:04.771067Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.104:2380"} {"level":"info","ts":"2026-09-22T03:42:04.77109Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.104:2380"} {"level":"info","ts":"2026-09-22T03:42:04.771188Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8572cc3a5351216d","initial-advertise-peer-urls":["https://162.253.55.104:2380"],"listen-peer-urls":["https://162.253.55.104:2380"],"advertise-client-urls":["https://162.253.55.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T03:42:04.771222Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T03:42:05.142206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T03:42:05.142253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T03:42:05.142294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d received MsgPreVoteResp from 8572cc3a5351216d at term 1"} {"level":"info","ts":"2026-09-22T03:42:05.142305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became candidate at term 2"} {"level":"info","ts":"2026-09-22T03:42:05.142325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d received MsgVoteResp from 8572cc3a5351216d at term 2"} {"level":"info","ts":"2026-09-22T03:42:05.142333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became leader at term 2"} {"level":"info","ts":"2026-09-22T03:42:05.142339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8572cc3a5351216d elected leader 8572cc3a5351216d at term 2"} {"level":"info","ts":"2026-09-22T03:42:05.146569Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8572cc3a5351216d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.104:2379]}","request-path":"/0/members/8572cc3a5351216d/attributes","cluster-id":"c1a156b8f69e6a79","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T03:42:05.146711Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T03:42:05.146752Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:42:05.146875Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T03:42:05.147277Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T03:42:05.147336Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T03:42:05.147975Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c1a156b8f69e6a79","local-member-id":"8572cc3a5351216d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:42:05.148151Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:42:05.148296Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T03:42:05.149212Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.104:2379"} {"level":"info","ts":"2026-09-22T03:42:05.151506Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T03:42:08.384838Z","caller":"traceutil/trace.go:171","msg":"trace[400465420] transaction","detail":"{read_only:false; response_revision:164; number_of_response:1; }","duration":"123.525778ms","start":"2026-09-22T03:42:08.261286Z","end":"2026-09-22T03:42:08.384812Z","steps":["trace[400465420] 'process raft request' (duration: 123.469586ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:08.384873Z","caller":"traceutil/trace.go:171","msg":"trace[727830229] transaction","detail":"{read_only:false; response_revision:163; number_of_response:1; }","duration":"125.361922ms","start":"2026-09-22T03:42:08.259473Z","end":"2026-09-22T03:42:08.384835Z","steps":["trace[727830229] 'process raft request' (duration: 114.014622ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.010196Z","caller":"traceutil/trace.go:171","msg":"trace[424818747] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"114.981546ms","start":"2026-09-22T03:42:10.895174Z","end":"2026-09-22T03:42:11.010155Z","steps":["trace[424818747] 'process raft request' (duration: 114.932394ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.010457Z","caller":"traceutil/trace.go:171","msg":"trace[641566781] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"119.23256ms","start":"2026-09-22T03:42:10.891197Z","end":"2026-09-22T03:42:11.01043Z","steps":["trace[641566781] 'process raft request' (duration: 76.586249ms)","trace[641566781] 'compare' (duration: 42.169098ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:11.01048Z","caller":"traceutil/trace.go:171","msg":"trace[789144493] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"115.336005ms","start":"2026-09-22T03:42:10.895098Z","end":"2026-09-22T03:42:11.010434Z","steps":["trace[789144493] 'read index received' (duration: 72.87011ms)","trace[789144493] 'applied index is now lower than readState.Index' (duration: 42.462015ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:42:11.010723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.589062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-22T03:42:11.010804Z","caller":"traceutil/trace.go:171","msg":"trace[1330647728] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:285; }","duration":"115.732106ms","start":"2026-09-22T03:42:10.895059Z","end":"2026-09-22T03:42:11.010791Z","steps":["trace[1330647728] 'agreement among raft nodes before linearized reading' (duration: 115.544121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.089131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.952244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-09-22T03:42:11.089236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.2483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:42:11.089253Z","caller":"traceutil/trace.go:171","msg":"trace[126456524] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:285; }","duration":"188.107138ms","start":"2026-09-22T03:42:10.901118Z","end":"2026-09-22T03:42:11.089225Z","steps":["trace[126456524] 'agreement among raft nodes before linearized reading' (duration: 187.868831ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.089316Z","caller":"traceutil/trace.go:171","msg":"trace[1226843092] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:285; }","duration":"192.379113ms","start":"2026-09-22T03:42:10.896913Z","end":"2026-09-22T03:42:11.089292Z","steps":["trace[1226843092] 'agreement among raft nodes before linearized reading' (duration: 192.197568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.339477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.150017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T03:42:11.339817Z","caller":"traceutil/trace.go:171","msg":"trace[156625861] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"325.306351ms","start":"2026-09-22T03:42:11.014467Z","end":"2026-09-22T03:42:11.339774Z","steps":["trace[156625861] 'process raft request' (duration: 221.987579ms)","trace[156625861] 'compare' (duration: 101.959172ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:11.33984Z","caller":"traceutil/trace.go:171","msg":"trace[807170703] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"324.297252ms","start":"2026-09-22T03:42:11.015516Z","end":"2026-09-22T03:42:11.339813Z","steps":["trace[807170703] 'process raft request' (duration: 324.137267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.339967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.015507Z","time spent":"324.401695ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:11.340017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.014454Z","time spent":"325.447616ms","remote":"127.0.0.1:56508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T03:42:11.340068Z","caller":"traceutil/trace.go:171","msg":"trace[33486867] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"324.328093ms","start":"2026-09-22T03:42:11.015713Z","end":"2026-09-22T03:42:11.340042Z","steps":["trace[33486867] 'process raft request' (duration: 323.994253ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.34018Z","caller":"traceutil/trace.go:171","msg":"trace[1566596165] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"246.927604ms","start":"2026-09-22T03:42:11.093235Z","end":"2026-09-22T03:42:11.340163Z","steps":["trace[1566596165] 'process raft request' (duration: 246.843182ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.340141Z","caller":"traceutil/trace.go:171","msg":"trace[464595169] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"323.565401ms","start":"2026-09-22T03:42:11.016462Z","end":"2026-09-22T03:42:11.340027Z","steps":["trace[464595169] 'process raft request' (duration: 323.346155ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.340217Z","caller":"traceutil/trace.go:171","msg":"trace[1208267324] transaction","detail":"{read_only:false; number_of_response:0; response_revision:289; }","duration":"320.0898ms","start":"2026-09-22T03:42:11.020111Z","end":"2026-09-22T03:42:11.3402Z","steps":["trace[1208267324] 'process raft request' (duration: 319.918275ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.340241Z","caller":"traceutil/trace.go:171","msg":"trace[950044351] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"321.916293ms","start":"2026-09-22T03:42:11.018304Z","end":"2026-09-22T03:42:11.34022Z","steps":["trace[950044351] 'process raft request' (duration: 321.561083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.340288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.0201Z","time spent":"320.154152ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:11.340285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.01645Z","time spent":"323.787567ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:11.34032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.018295Z","time spent":"321.988135ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:11.340377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.892419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-09-22T03:42:11.340223Z","caller":"traceutil/trace.go:171","msg":"trace[946091105] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:291; }","duration":"251.499838ms","start":"2026-09-22T03:42:11.088705Z","end":"2026-09-22T03:42:11.340205Z","steps":["trace[946091105] 'read index received' (duration: 147.920128ms)","trace[946091105] 'applied index is now lower than readState.Index' (duration: 103.577109ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:11.340387Z","caller":"traceutil/trace.go:171","msg":"trace[1482705906] transaction","detail":"{read_only:false; number_of_response:0; response_revision:289; }","duration":"320.940645ms","start":"2026-09-22T03:42:11.019437Z","end":"2026-09-22T03:42:11.340378Z","steps":["trace[1482705906] 'process raft request' (duration: 320.530233ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.340422Z","caller":"traceutil/trace.go:171","msg":"trace[1513983478] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:290; }","duration":"325.976872ms","start":"2026-09-22T03:42:11.014431Z","end":"2026-09-22T03:42:11.340408Z","steps":["trace[1513983478] 'agreement among raft nodes before linearized reading' (duration: 325.819327ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.340472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.014414Z","time spent":"326.047153ms","remote":"127.0.0.1:56770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-22T03:42:11.340485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.019428Z","time spent":"321.026478ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:11.340591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.026063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"warn","ts":"2026-09-22T03:42:11.340632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.025596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-09-22T03:42:11.340683Z","caller":"traceutil/trace.go:171","msg":"trace[1465923415] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:290; }","duration":"248.076817ms","start":"2026-09-22T03:42:11.092591Z","end":"2026-09-22T03:42:11.340667Z","steps":["trace[1465923415] 'agreement among raft nodes before linearized reading' (duration: 247.979194ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:11.340643Z","caller":"traceutil/trace.go:171","msg":"trace[1967193539] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:290; }","duration":"250.108926ms","start":"2026-09-22T03:42:11.090517Z","end":"2026-09-22T03:42:11.340626Z","steps":["trace[1967193539] 'agreement among raft nodes before linearized reading' (duration: 249.999794ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.340692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.274291ms","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-09-22T03:42:11.340811Z","caller":"traceutil/trace.go:171","msg":"trace[2005803968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:290; }","duration":"239.426495ms","start":"2026-09-22T03:42:11.101355Z","end":"2026-09-22T03:42:11.340781Z","steps":["trace[2005803968] 'agreement among raft nodes before linearized reading' (duration: 239.202479ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:11.341118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.015706Z","time spent":"324.458506ms","remote":"127.0.0.1:56536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:11.855897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.747679ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T03:42:11.856245Z","caller":"traceutil/trace.go:171","msg":"trace[1298986059] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"422.584168ms","start":"2026-09-22T03:42:11.433608Z","end":"2026-09-22T03:42:11.856192Z","steps":["trace[1298986059] 'process raft request' (duration: 17.436547ms)","trace[1298986059] 'compare' (duration: 404.518733ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:42:11.856384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.433587Z","time spent":"422.766352ms","remote":"127.0.0.1:56614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T03:42:12.504592Z","caller":"traceutil/trace.go:171","msg":"trace[593554886] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"1.070841846s","start":"2026-09-22T03:42:11.433711Z","end":"2026-09-22T03:42:12.504553Z","steps":["trace[593554886] 'process raft request' (duration: 1.040927726s)","trace[593554886] 'compare' (duration: 29.633972ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:12.50465Z","caller":"traceutil/trace.go:171","msg":"trace[114002504] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:304; }","duration":"1.070853676s","start":"2026-09-22T03:42:11.433768Z","end":"2026-09-22T03:42:12.504622Z","steps":["trace[114002504] 'read index received' (duration: 17.292903ms)","trace[114002504] 'applied index is now lower than readState.Index' (duration: 1.053559883s)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:12.504673Z","caller":"traceutil/trace.go:171","msg":"trace[1785868296] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"1.068253791s","start":"2026-09-22T03:42:11.436394Z","end":"2026-09-22T03:42:12.504648Z","steps":["trace[1785868296] 'process raft request' (duration: 1.068107637s)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:12.504796Z","caller":"traceutil/trace.go:171","msg":"trace[938590979] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"1.060264619s","start":"2026-09-22T03:42:11.444479Z","end":"2026-09-22T03:42:12.504743Z","steps":["trace[938590979] 'process raft request' (duration: 1.060068993s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.504813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.436367Z","time spent":"1.068366594s","remote":"127.0.0.1:56614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":170,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:12.50496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071173735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-22T03:42:12.505071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.433691Z","time spent":"1.071009831s","remote":"127.0.0.1:56508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T03:42:12.505102Z","caller":"traceutil/trace.go:171","msg":"trace[2081281953] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:300; }","duration":"1.071471234s","start":"2026-09-22T03:42:11.433616Z","end":"2026-09-22T03:42:12.505087Z","steps":["trace[2081281953] 'agreement among raft nodes before linearized reading' (duration: 1.071126864s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.505137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.433593Z","time spent":"1.071534606s","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-22T03:42:12.50515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.444462Z","time spent":"1.060389723s","remote":"127.0.0.1:56606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4183,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T03:42:12.504608Z","caller":"traceutil/trace.go:171","msg":"trace[293916672] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"1.070051162s","start":"2026-09-22T03:42:11.434532Z","end":"2026-09-22T03:42:12.504583Z","steps":["trace[293916672] 'process raft request' (duration: 1.069925009s)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.505661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.434477Z","time spent":"1.070814024s","remote":"127.0.0.1:56508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T03:42:12.511377Z","caller":"traceutil/trace.go:171","msg":"trace[2077944014] transaction","detail":"{read_only:false; number_of_response:0; response_revision:300; }","duration":"576.848993ms","start":"2026-09-22T03:42:11.934504Z","end":"2026-09-22T03:42:12.511353Z","steps":["trace[2077944014] 'process raft request' (duration: 576.777791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.51147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.219635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T03:42:12.511535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.934495Z","time spent":"576.964686ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T03:42:12.511585Z","caller":"traceutil/trace.go:171","msg":"trace[695282462] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:300; }","duration":"649.451662ms","start":"2026-09-22T03:42:11.862112Z","end":"2026-09-22T03:42:12.511564Z","steps":["trace[695282462] 'agreement among raft nodes before linearized reading' (duration: 649.232145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.511632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.862066Z","time spent":"649.557145ms","remote":"127.0.0.1:56614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-09-22T03:42:12.511654Z","caller":"traceutil/trace.go:171","msg":"trace[462790599] transaction","detail":"{read_only:false; number_of_response:0; response_revision:300; }","duration":"578.393786ms","start":"2026-09-22T03:42:11.933192Z","end":"2026-09-22T03:42:12.511586Z","steps":["trace[462790599] 'process raft request' (duration: 578.001805ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:12.511865Z","caller":"traceutil/trace.go:171","msg":"trace[1499545565] transaction","detail":"{read_only:false; number_of_response:0; response_revision:300; }","duration":"576.545343ms","start":"2026-09-22T03:42:11.935309Z","end":"2026-09-22T03:42:12.511854Z","steps":["trace[1499545565] 'process raft request' (duration: 576.005638ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.511953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.935301Z","time spent":"576.596245ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:12.511949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.933176Z","time spent":"578.652755ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T03:42:12.512147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.438346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-22T03:42:12.512182Z","caller":"traceutil/trace.go:171","msg":"trace[265892276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:300; }","duration":"157.517858ms","start":"2026-09-22T03:42:12.354655Z","end":"2026-09-22T03:42:12.512173Z","steps":["trace[265892276] 'agreement among raft nodes before linearized reading' (duration: 157.452076ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.512352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.843569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-09-22T03:42:12.51238Z","caller":"traceutil/trace.go:171","msg":"trace[223791096] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:300; }","duration":"579.91131ms","start":"2026-09-22T03:42:11.932461Z","end":"2026-09-22T03:42:12.512372Z","steps":["trace[223791096] 'agreement among raft nodes before linearized reading' (duration: 579.784877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:12.512406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:11.932436Z","time spent":"579.964262ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2944,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-09-22T03:42:18.499479Z","caller":"traceutil/trace.go:171","msg":"trace[1794861974] linearizableReadLoop","detail":"{readStateIndex:413; appliedIndex:412; }","duration":"200.821236ms","start":"2026-09-22T03:42:18.298622Z","end":"2026-09-22T03:42:18.499444Z","steps":["trace[1794861974] 'read index received' (duration: 200.643671ms)","trace[1794861974] 'applied index is now lower than readState.Index' (duration: 176.795µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:18.49959Z","caller":"traceutil/trace.go:171","msg":"trace[21579528] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"461.533358ms","start":"2026-09-22T03:42:18.038047Z","end":"2026-09-22T03:42:18.499581Z","steps":["trace[21579528] 'process raft request' (duration: 461.278381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:18.499683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:18.038028Z","time spent":"461.586109ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T03:42:18.500085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.708478ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:42:18.500229Z","caller":"traceutil/trace.go:171","msg":"trace[363793239] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:399; }","duration":"119.837182ms","start":"2026-09-22T03:42:18.380349Z","end":"2026-09-22T03:42:18.500186Z","steps":["trace[363793239] 'agreement among raft nodes before linearized reading' (duration: 119.677028ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:18.500897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.268546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:42:18.500952Z","caller":"traceutil/trace.go:171","msg":"trace[1734885594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:399; }","duration":"202.360239ms","start":"2026-09-22T03:42:18.298574Z","end":"2026-09-22T03:42:18.500934Z","steps":["trace[1734885594] 'agreement among raft nodes before linearized reading' (duration: 201.207497ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:18.976596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.348102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T03:42:18.976837Z","caller":"traceutil/trace.go:171","msg":"trace[1735432419] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"439.695319ms","start":"2026-09-22T03:42:18.537039Z","end":"2026-09-22T03:42:18.976734Z","steps":["trace[1735432419] 'read index received' (duration: 334.159003ms)","trace[1735432419] 'applied index is now lower than readState.Index' (duration: 105.534876ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:18.976887Z","caller":"traceutil/trace.go:171","msg":"trace[1913598103] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"464.306453ms","start":"2026-09-22T03:42:18.512542Z","end":"2026-09-22T03:42:18.976849Z","steps":["trace[1913598103] 'process raft request' (duration: 358.635613ms)","trace[1913598103] 'compare' (duration: 105.206737ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:42:18.976966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.931906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-22T03:42:18.977034Z","caller":"traceutil/trace.go:171","msg":"trace[1754906156] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"440.034718ms","start":"2026-09-22T03:42:18.536991Z","end":"2026-09-22T03:42:18.977026Z","steps":["trace[1754906156] 'agreement among raft nodes before linearized reading' (duration: 439.936776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:18.977038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.00893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-22T03:42:18.977084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:18.512523Z","time spent":"464.470738ms","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5321,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T03:42:18.97711Z","caller":"traceutil/trace.go:171","msg":"trace[250637956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:400; }","duration":"436.116122ms","start":"2026-09-22T03:42:18.540972Z","end":"2026-09-22T03:42:18.977088Z","steps":["trace[250637956] 'agreement among raft nodes before linearized reading' (duration: 435.995949ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:18.977075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:18.536966Z","time spent":"440.100401ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-22T03:42:18.977154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:18.540951Z","time spent":"436.194135ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-22T03:42:18.977399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.939839ms","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-22T03:42:18.977479Z","caller":"traceutil/trace.go:171","msg":"trace[1555178029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:400; }","duration":"383.067412ms","start":"2026-09-22T03:42:18.594394Z","end":"2026-09-22T03:42:18.977462Z","steps":["trace[1555178029] 'agreement among raft nodes before linearized reading' (duration: 382.803365ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:18.977686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:18.594375Z","time spent":"383.230827ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-22T03:42:43.515887Z","caller":"traceutil/trace.go:171","msg":"trace[1618012480] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"128.024539ms","start":"2026-09-22T03:42:43.38782Z","end":"2026-09-22T03:42:43.515845Z","steps":["trace[1618012480] 'process raft request' (duration: 83.376524ms)","trace[1618012480] 'compare' (duration: 44.489533ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:43.515947Z","caller":"traceutil/trace.go:171","msg":"trace[58645802] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"126.077097ms","start":"2026-09-22T03:42:43.389827Z","end":"2026-09-22T03:42:43.515904Z","steps":["trace[58645802] 'process raft request' (duration: 126.021346ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:43.516137Z","caller":"traceutil/trace.go:171","msg":"trace[389372379] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"126.717021ms","start":"2026-09-22T03:42:43.38938Z","end":"2026-09-22T03:42:43.516097Z","steps":["trace[389372379] 'process raft request' (duration: 126.421125ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:45.358641Z","caller":"traceutil/trace.go:171","msg":"trace[1346077907] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"117.951782ms","start":"2026-09-22T03:42:45.240661Z","end":"2026-09-22T03:42:45.358613Z","steps":["trace[1346077907] 'process raft request' (duration: 117.749508ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:45.358951Z","caller":"traceutil/trace.go:171","msg":"trace[2120004634] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"116.477901ms","start":"2026-09-22T03:42:45.242461Z","end":"2026-09-22T03:42:45.358939Z","steps":["trace[2120004634] 'process raft request' (duration: 116.40582ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:51.467555Z","caller":"traceutil/trace.go:171","msg":"trace[697569593] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"129.969024ms","start":"2026-09-22T03:42:51.337555Z","end":"2026-09-22T03:42:51.467524Z","steps":["trace[697569593] 'process raft request' (duration: 118.960437ms)","trace[697569593] 'compare' (duration: 10.349384ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:51.714605Z","caller":"traceutil/trace.go:171","msg":"trace[1227109780] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"185.005651ms","start":"2026-09-22T03:42:51.529572Z","end":"2026-09-22T03:42:51.714577Z","steps":["trace[1227109780] 'process raft request' (duration: 135.052375ms)","trace[1227109780] 'compare' (duration: 49.716581ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:52.284881Z","caller":"traceutil/trace.go:171","msg":"trace[1020418412] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"224.634146ms","start":"2026-09-22T03:42:52.06022Z","end":"2026-09-22T03:42:52.284854Z","steps":["trace[1020418412] 'process raft request' (duration: 224.168087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:52.80011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2408758153158707782,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-22T03:42:53.104568Z","caller":"traceutil/trace.go:171","msg":"trace[470526980] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"805.400123ms","start":"2026-09-22T03:42:52.299135Z","end":"2026-09-22T03:42:53.104535Z","steps":["trace[470526980] 'read index received' (duration: 804.18772ms)","trace[470526980] 'applied index is now lower than readState.Index' (duration: 1.210893ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:42:53.104699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.551197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:42:53.104666Z","caller":"traceutil/trace.go:171","msg":"trace[664245971] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"940.303924ms","start":"2026-09-22T03:42:52.164309Z","end":"2026-09-22T03:42:53.104613Z","steps":["trace[664245971] 'process raft request' (duration: 939.482369ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:42:53.104731Z","caller":"traceutil/trace.go:171","msg":"trace[392379204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"805.640948ms","start":"2026-09-22T03:42:52.299079Z","end":"2026-09-22T03:42:53.10472Z","steps":["trace[392379204] 'agreement among raft nodes before linearized reading' (duration: 805.561346ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:53.104772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:52.299051Z","time spent":"805.7142ms","remote":"127.0.0.1:56438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-22T03:42:53.104917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:42:52.164275Z","time spent":"940.500357ms","remote":"127.0.0.1:56522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T03:42:55.622302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.935629ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T03:42:55.622403Z","caller":"traceutil/trace.go:171","msg":"trace[492868658] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"241.821616ms","start":"2026-09-22T03:42:55.380564Z","end":"2026-09-22T03:42:55.622386Z","steps":["trace[492868658] 'read index received' (duration: 131.655993ms)","trace[492868658] 'applied index is now lower than readState.Index' (duration: 110.164263ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:42:55.622609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.03569ms","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-22T03:42:55.622643Z","caller":"traceutil/trace.go:171","msg":"trace[1842263520] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:665; }","duration":"242.098681ms","start":"2026-09-22T03:42:55.380536Z","end":"2026-09-22T03:42:55.622634Z","steps":["trace[1842263520] 'agreement among raft nodes before linearized reading' (duration: 241.917157ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:42:55.622699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.251361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-22T03:42:55.622518Z","caller":"traceutil/trace.go:171","msg":"trace[818493040] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"248.065575ms","start":"2026-09-22T03:42:55.374356Z","end":"2026-09-22T03:42:55.622422Z","steps":["trace[818493040] 'process raft request' (duration: 137.947643ms)","trace[818493040] 'compare' (duration: 109.780105ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:42:55.622877Z","caller":"traceutil/trace.go:171","msg":"trace[1998145126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"103.467535ms","start":"2026-09-22T03:42:55.51939Z","end":"2026-09-22T03:42:55.622857Z","steps":["trace[1998145126] 'agreement among raft nodes before linearized reading' (duration: 103.121169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:11.88259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.504962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-22T03:43:11.882643Z","caller":"traceutil/trace.go:171","msg":"trace[2132693455] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:813; }","duration":"100.022876ms","start":"2026-09-22T03:43:11.782592Z","end":"2026-09-22T03:43:11.882615Z","steps":["trace[2132693455] 'range keys from in-memory index tree' (duration: 99.570958ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:43:11.882689Z","caller":"traceutil/trace.go:171","msg":"trace[1605481694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:813; }","duration":"146.654283ms","start":"2026-09-22T03:43:11.736017Z","end":"2026-09-22T03:43:11.882672Z","steps":["trace[1605481694] 'range keys from in-memory index tree' (duration: 146.367069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:43:11.88275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.419455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-22T03:43:11.882842Z","caller":"traceutil/trace.go:171","msg":"trace[1080695850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:813; }","duration":"141.514587ms","start":"2026-09-22T03:43:11.741274Z","end":"2026-09-22T03:43:11.882789Z","steps":["trace[1080695850] 'range keys from in-memory index tree' (duration: 141.282844ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:44:04.629261Z","caller":"traceutil/trace.go:171","msg":"trace[175448267] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"107.462532ms","start":"2026-09-22T03:44:04.521772Z","end":"2026-09-22T03:44:04.629235Z","steps":["trace[175448267] 'process raft request' (duration: 107.296609ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:44:31.32849Z","caller":"traceutil/trace.go:171","msg":"trace[1466184112] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"456.322976ms","start":"2026-09-22T03:44:30.872096Z","end":"2026-09-22T03:44:31.328419Z","steps":["trace[1466184112] 'process raft request' (duration: 361.111799ms)","trace[1466184112] 'compare' (duration: 94.894204ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:44:31.328659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:44:30.872087Z","time spent":"456.485849ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T03:44:31.731023Z","caller":"traceutil/trace.go:171","msg":"trace[1202442120] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"184.512897ms","start":"2026-09-22T03:44:31.546487Z","end":"2026-09-22T03:44:31.731Z","steps":["trace[1202442120] 'process raft request' (duration: 184.301515ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:44:47.698268Z","caller":"traceutil/trace.go:171","msg":"trace[1865183378] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"257.669429ms","start":"2026-09-22T03:44:47.440573Z","end":"2026-09-22T03:44:47.698243Z","steps":["trace[1865183378] 'process raft request' (duration: 257.476247ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:45:10.102572Z","caller":"traceutil/trace.go:171","msg":"trace[1203289660] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"289.537646ms","start":"2026-09-22T03:45:09.813015Z","end":"2026-09-22T03:45:10.102552Z","steps":["trace[1203289660] 'process raft request' (duration: 289.367235ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:46:04.854802Z","caller":"traceutil/trace.go:171","msg":"trace[2061744030] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"358.594605ms","start":"2026-09-22T03:46:04.496185Z","end":"2026-09-22T03:46:04.854779Z","steps":["trace[2061744030] 'process raft request' (duration: 358.461511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:46:04.85516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:46:04.496168Z","time spent":"358.708678ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T03:46:04.860446Z","caller":"traceutil/trace.go:171","msg":"trace[1836493424] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"350.530474ms","start":"2026-09-22T03:46:04.509898Z","end":"2026-09-22T03:46:04.860428Z","steps":["trace[1836493424] 'process raft request' (duration: 350.423842ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:46:04.860532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T03:46:04.509881Z","time spent":"350.608496ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T03:50:09.176695Z","caller":"traceutil/trace.go:171","msg":"trace[848625479] transaction","detail":"{read_only:false; response_revision:3924; number_of_response:1; }","duration":"113.069903ms","start":"2026-09-22T03:50:09.063604Z","end":"2026-09-22T03:50:09.176674Z","steps":["trace[848625479] 'process raft request' (duration: 111.274266ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:50:50.443844Z","caller":"traceutil/trace.go:171","msg":"trace[1853166052] transaction","detail":"{read_only:false; response_revision:4214; number_of_response:1; }","duration":"108.462326ms","start":"2026-09-22T03:50:50.335339Z","end":"2026-09-22T03:50:50.443801Z","steps":["trace[1853166052] 'process raft request' (duration: 108.310074ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:12.503666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.428396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-c7bd54d7-sfwzz\" ","response":"range_response_count:1 size:3848"} {"level":"info","ts":"2026-09-22T03:51:12.503751Z","caller":"traceutil/trace.go:171","msg":"trace[1354352523] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-c7bd54d7-sfwzz; range_end:; response_count:1; response_revision:4542; }","duration":"110.554518ms","start":"2026-09-22T03:51:12.393177Z","end":"2026-09-22T03:51:12.503731Z","steps":["trace[1354352523] 'agreement among raft nodes before linearized reading' (duration: 110.347465ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:12.503842Z","caller":"traceutil/trace.go:171","msg":"trace[424460452] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"103.334087ms","start":"2026-09-22T03:51:12.400484Z","end":"2026-09-22T03:51:12.503818Z","steps":["trace[424460452] 'process raft request' (duration: 79.099492ms)","trace[424460452] 'compare' (duration: 23.418564ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:12.503935Z","caller":"traceutil/trace.go:171","msg":"trace[186218730] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"100.982655ms","start":"2026-09-22T03:51:12.402942Z","end":"2026-09-22T03:51:12.503925Z","steps":["trace[186218730] 'process raft request' (duration: 100.472858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:12.504549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.469966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:10877"} {"level":"info","ts":"2026-09-22T03:51:12.504593Z","caller":"traceutil/trace.go:171","msg":"trace[1090269632] range","detail":"{range_begin:/registry/deployments/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:4542; }","duration":"110.529346ms","start":"2026-09-22T03:51:12.394052Z","end":"2026-09-22T03:51:12.504581Z","steps":["trace[1090269632] 'agreement among raft nodes before linearized reading' (duration: 110.409716ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:13.717666Z","caller":"traceutil/trace.go:171","msg":"trace[155847985] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"133.536542ms","start":"2026-09-22T03:51:13.584101Z","end":"2026-09-22T03:51:13.717638Z","steps":["trace[155847985] 'process raft request' (duration: 67.892707ms)","trace[155847985] 'compare' (duration: 64.884284ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:18.715791Z","caller":"traceutil/trace.go:171","msg":"trace[1880060777] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4806; }","duration":"121.183374ms","start":"2026-09-22T03:51:18.594586Z","end":"2026-09-22T03:51:18.715769Z","steps":["trace[1880060777] 'process raft request' (duration: 98.201709ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:18.730486Z","caller":"traceutil/trace.go:171","msg":"trace[309703947] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"100.992906ms","start":"2026-09-22T03:51:18.629474Z","end":"2026-09-22T03:51:18.730467Z","steps":["trace[309703947] 'process raft request' (duration: 100.5822ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:22.899474Z","caller":"traceutil/trace.go:171","msg":"trace[33758296] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"146.892809ms","start":"2026-09-22T03:51:22.75255Z","end":"2026-09-22T03:51:22.899443Z","steps":["trace[33758296] 'process raft request' (duration: 89.513265ms)","trace[33758296] 'compare' (duration: 57.159191ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:22.899647Z","caller":"traceutil/trace.go:171","msg":"trace[1447711355] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5076; }","duration":"129.071295ms","start":"2026-09-22T03:51:22.770554Z","end":"2026-09-22T03:51:22.899625Z","steps":["trace[1447711355] 'read index received' (duration: 71.522129ms)","trace[1447711355] 'applied index is now lower than readState.Index' (duration: 57.547426ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:22.899953Z","caller":"traceutil/trace.go:171","msg":"trace[1121032623] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"128.766361ms","start":"2026-09-22T03:51:22.771177Z","end":"2026-09-22T03:51:22.899944Z","steps":["trace[1121032623] 'process raft request' (duration: 128.468367ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:22.899962Z","caller":"traceutil/trace.go:171","msg":"trace[410334001] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"101.915103ms","start":"2026-09-22T03:51:22.798034Z","end":"2026-09-22T03:51:22.899949Z","steps":["trace[410334001] 'process raft request' (duration: 101.866272ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:22.900126Z","caller":"traceutil/trace.go:171","msg":"trace[795594054] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"129.43083ms","start":"2026-09-22T03:51:22.770688Z","end":"2026-09-22T03:51:22.900118Z","steps":["trace[795594054] 'process raft request' (duration: 128.760881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:22.900113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.543252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:56937"} {"level":"info","ts":"2026-09-22T03:51:22.900431Z","caller":"traceutil/trace.go:171","msg":"trace[1037609405] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"119.504154ms","start":"2026-09-22T03:51:22.780911Z","end":"2026-09-22T03:51:22.900415Z","steps":["trace[1037609405] 'process raft request' (duration: 118.921736ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:22.901397Z","caller":"traceutil/trace.go:171","msg":"trace[819689691] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4891; }","duration":"130.558326ms","start":"2026-09-22T03:51:22.770548Z","end":"2026-09-22T03:51:22.901106Z","steps":["trace[819689691] 'agreement among raft nodes before linearized reading' (duration: 129.268498ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:22.918733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.930151ms","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-09-22T03:51:22.918798Z","caller":"traceutil/trace.go:171","msg":"trace[931749294] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4894; }","duration":"107.030023ms","start":"2026-09-22T03:51:22.811753Z","end":"2026-09-22T03:51:22.918783Z","steps":["trace[931749294] 'agreement among raft nodes before linearized reading' (duration: 106.927352ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.116058Z","caller":"traceutil/trace.go:171","msg":"trace[1102323445] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"191.079862ms","start":"2026-09-22T03:51:22.924954Z","end":"2026-09-22T03:51:23.116033Z","steps":["trace[1102323445] 'process raft request' (duration: 190.99141ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.116099Z","caller":"traceutil/trace.go:171","msg":"trace[1611157711] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"191.163033ms","start":"2026-09-22T03:51:22.924883Z","end":"2026-09-22T03:51:23.116046Z","steps":["trace[1611157711] 'process raft request' (duration: 94.883377ms)","trace[1611157711] 'compare' (duration: 96.041043ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:23.116279Z","caller":"traceutil/trace.go:171","msg":"trace[1725577494] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"191.224624ms","start":"2026-09-22T03:51:22.925043Z","end":"2026-09-22T03:51:23.116268Z","steps":["trace[1725577494] 'process raft request' (duration: 191.075762ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.11629Z","caller":"traceutil/trace.go:171","msg":"trace[1648556633] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"191.273325ms","start":"2026-09-22T03:51:22.924986Z","end":"2026-09-22T03:51:23.116259Z","steps":["trace[1648556633] 'process raft request' (duration: 191.010171ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.116313Z","caller":"traceutil/trace.go:171","msg":"trace[415129012] linearizableReadLoop","detail":"{readStateIndex:5089; appliedIndex:5083; }","duration":"158.176942ms","start":"2026-09-22T03:51:22.958118Z","end":"2026-09-22T03:51:23.116295Z","steps":["trace[415129012] 'read index received' (duration: 61.886446ms)","trace[415129012] 'applied index is now lower than readState.Index' (duration: 96.289496ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:23.116403Z","caller":"traceutil/trace.go:171","msg":"trace[1582720665] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"190.507704ms","start":"2026-09-22T03:51:22.925885Z","end":"2026-09-22T03:51:23.116393Z","steps":["trace[1582720665] 'process raft request' (duration: 190.340131ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.116616Z","caller":"traceutil/trace.go:171","msg":"trace[1686900469] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"188.72332ms","start":"2026-09-22T03:51:22.92788Z","end":"2026-09-22T03:51:23.116604Z","steps":["trace[1686900469] 'process raft request' (duration: 188.381375ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:23.117818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.020499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362739"} {"level":"info","ts":"2026-09-22T03:51:23.117888Z","caller":"traceutil/trace.go:171","msg":"trace[581895455] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4901; }","duration":"169.1307ms","start":"2026-09-22T03:51:22.948742Z","end":"2026-09-22T03:51:23.117873Z","steps":["trace[581895455] 'agreement among raft nodes before linearized reading' (duration: 167.937005ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.120251Z","caller":"traceutil/trace.go:171","msg":"trace[677618736] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"157.764366ms","start":"2026-09-22T03:51:22.962463Z","end":"2026-09-22T03:51:23.120228Z","steps":["trace[677618736] 'process raft request' (duration: 157.572144ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.1203Z","caller":"traceutil/trace.go:171","msg":"trace[718722061] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"152.27425ms","start":"2026-09-22T03:51:22.968003Z","end":"2026-09-22T03:51:23.120278Z","steps":["trace[718722061] 'process raft request' (duration: 152.119559ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:23.120368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.80666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-44270747-f3e4-4606-9023-362f750bf3c4\" ","response":"range_response_count:1 size:1450"} {"level":"warn","ts":"2026-09-22T03:51:23.12038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.803578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:51:23.120425Z","caller":"traceutil/trace.go:171","msg":"trace[143724382] range","detail":"{range_begin:/registry/persistentvolumes/pvc-44270747-f3e4-4606-9023-362f750bf3c4; range_end:; response_count:1; response_revision:4903; }","duration":"158.895981ms","start":"2026-09-22T03:51:22.961517Z","end":"2026-09-22T03:51:23.120413Z","steps":["trace[143724382] 'agreement among raft nodes before linearized reading' (duration: 158.701109ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:23.120436Z","caller":"traceutil/trace.go:171","msg":"trace[64714093] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:4903; }","duration":"117.90697ms","start":"2026-09-22T03:51:23.002515Z","end":"2026-09-22T03:51:23.120422Z","steps":["trace[64714093] 'agreement among raft nodes before linearized reading' (duration: 117.805229ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:28.900793Z","caller":"traceutil/trace.go:171","msg":"trace[342732239] linearizableReadLoop","detail":"{readStateIndex:5194; appliedIndex:5193; }","duration":"189.249904ms","start":"2026-09-22T03:51:28.711521Z","end":"2026-09-22T03:51:28.900771Z","steps":["trace[342732239] 'read index received' (duration: 162.052263ms)","trace[342732239] 'applied index is now lower than readState.Index' (duration: 27.196501ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:28.900854Z","caller":"traceutil/trace.go:171","msg":"trace[1837325861] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"277.25965ms","start":"2026-09-22T03:51:28.623561Z","end":"2026-09-22T03:51:28.90082Z","steps":["trace[1837325861] 'process raft request' (duration: 250.06597ms)","trace[1837325861] 'compare' (duration: 27.053088ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:51:28.90095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.401676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d786f57-9a5f-407a-8aa1-474fd14133f6\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-09-22T03:51:28.901021Z","caller":"traceutil/trace.go:171","msg":"trace[174838156] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d786f57-9a5f-407a-8aa1-474fd14133f6; range_end:; response_count:1; response_revision:5003; }","duration":"189.528488ms","start":"2026-09-22T03:51:28.711474Z","end":"2026-09-22T03:51:28.901002Z","steps":["trace[174838156] 'agreement among raft nodes before linearized reading' (duration: 189.377936ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:29.187284Z","caller":"traceutil/trace.go:171","msg":"trace[9233283] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5196; }","duration":"104.392067ms","start":"2026-09-22T03:51:29.082858Z","end":"2026-09-22T03:51:29.18725Z","steps":["trace[9233283] 'read index received' (duration: 69.623665ms)","trace[9233283] 'applied index is now lower than readState.Index' (duration: 34.766962ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:29.187362Z","caller":"traceutil/trace.go:171","msg":"trace[1712659678] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"116.043396ms","start":"2026-09-22T03:51:29.071254Z","end":"2026-09-22T03:51:29.187297Z","steps":["trace[1712659678] 'process raft request' (duration: 81.199323ms)","trace[1712659678] 'compare' (duration: 34.589919ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T03:51:29.187525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.650761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:51:29.18821Z","caller":"traceutil/trace.go:171","msg":"trace[332758101] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5005; }","duration":"105.378211ms","start":"2026-09-22T03:51:29.08281Z","end":"2026-09-22T03:51:29.188189Z","steps":["trace[332758101] 'agreement among raft nodes before linearized reading' (duration: 104.57968ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:34.333915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.995513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-09-22T03:51:34.333999Z","caller":"traceutil/trace.go:171","msg":"trace[1570094211] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5088; }","duration":"154.110635ms","start":"2026-09-22T03:51:34.179866Z","end":"2026-09-22T03:51:34.333976Z","steps":["trace[1570094211] 'range keys from in-memory index tree' (duration: 153.855821ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:42.425155Z","caller":"traceutil/trace.go:171","msg":"trace[632853510] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"241.495054ms","start":"2026-09-22T03:51:42.183639Z","end":"2026-09-22T03:51:42.425134Z","steps":["trace[632853510] 'process raft request' (duration: 241.323002ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:42.908385Z","caller":"traceutil/trace.go:171","msg":"trace[1955497946] linearizableReadLoop","detail":"{readStateIndex:5371; appliedIndex:5370; }","duration":"169.77424ms","start":"2026-09-22T03:51:42.738589Z","end":"2026-09-22T03:51:42.908364Z","steps":["trace[1955497946] 'read index received' (duration: 169.575127ms)","trace[1955497946] 'applied index is now lower than readState.Index' (duration: 198.083µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:51:42.908524Z","caller":"traceutil/trace.go:171","msg":"trace[1706654464] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"190.172265ms","start":"2026-09-22T03:51:42.718318Z","end":"2026-09-22T03:51:42.90849Z","steps":["trace[1706654464] 'process raft request' (duration: 189.915881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:42.908595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.984714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9635"} {"level":"info","ts":"2026-09-22T03:51:42.908639Z","caller":"traceutil/trace.go:171","msg":"trace[145501628] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5174; }","duration":"170.078545ms","start":"2026-09-22T03:51:42.738547Z","end":"2026-09-22T03:51:42.908625Z","steps":["trace[145501628] 'agreement among raft nodes before linearized reading' (duration: 169.923752ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:42.908757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.381416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-09-22T03:51:42.908802Z","caller":"traceutil/trace.go:171","msg":"trace[1190656507] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5174; }","duration":"169.447327ms","start":"2026-09-22T03:51:42.73934Z","end":"2026-09-22T03:51:42.908788Z","steps":["trace[1190656507] 'agreement among raft nodes before linearized reading' (duration: 169.330825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:51:42.908901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.353996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T03:51:42.90896Z","caller":"traceutil/trace.go:171","msg":"trace[1233678095] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:5174; }","duration":"146.434847ms","start":"2026-09-22T03:51:42.76251Z","end":"2026-09-22T03:51:42.908945Z","steps":["trace[1233678095] 'agreement among raft nodes before linearized reading' (duration: 146.277745ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:51:54.09512Z","caller":"traceutil/trace.go:171","msg":"trace[1479026401] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"130.282243ms","start":"2026-09-22T03:51:53.964812Z","end":"2026-09-22T03:51:54.095094Z","steps":["trace[1479026401] 'process raft request' (duration: 70.365437ms)","trace[1479026401] 'compare' (duration: 59.760864ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T03:52:05.172845Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-09-22T03:52:05.245077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"71.042687ms","hash":1394709930,"current-db-size-bytes":51552256,"current-db-size":"52 MB","current-db-size-in-use-bytes":28004352,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-22T03:52:05.245318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1394709930,"revision":2873,"compact-revision":-1} {"level":"info","ts":"2026-09-22T03:52:17.649896Z","caller":"traceutil/trace.go:171","msg":"trace[394527551] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"105.091335ms","start":"2026-09-22T03:52:17.544781Z","end":"2026-09-22T03:52:17.649872Z","steps":["trace[394527551] 'process raft request' (duration: 104.74198ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T03:55:47.354749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.578597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-22T03:55:47.354838Z","caller":"traceutil/trace.go:171","msg":"trace[1794649803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6974; }","duration":"118.70875ms","start":"2026-09-22T03:55:47.23611Z","end":"2026-09-22T03:55:47.354818Z","steps":["trace[1794649803] 'range keys from in-memory index tree' (duration: 118.446044ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T03:57:05.183606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5348} {"level":"info","ts":"2026-09-22T03:57:05.2613Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5348,"took":"75.990797ms","hash":780512321,"current-db-size-bytes":51552256,"current-db-size":"52 MB","current-db-size-in-use-bytes":18706432,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-22T03:57:05.261353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":780512321,"revision":5348,"compact-revision":2873} {"level":"info","ts":"2026-09-22T03:57:30.160058Z","caller":"traceutil/trace.go:171","msg":"trace[322982056] transaction","detail":"{read_only:false; response_revision:7521; number_of_response:1; }","duration":"107.683649ms","start":"2026-09-22T03:57:30.052346Z","end":"2026-09-22T03:57:30.16003Z","steps":["trace[322982056] 'process raft request' (duration: 107.452454ms)"],"step_count":1}