{"level":"warn","ts":"2026-09-18T15:17:36.515831Z","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-18T15:17:36.515967Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.22: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.22:2380","--initial-cluster=instance=https://162.253.55.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.22: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-18T15:17:36.516103Z","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-18T15:17:36.516119Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.22:2380"]} {"level":"info","ts":"2026-09-18T15:17:36.516138Z","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-18T15:17:36.516778Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"]} {"level":"info","ts":"2026-09-18T15:17:36.51692Z","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.22:2380"],"listen-peer-urls":["https://162.253.55.22:2380"],"advertise-client-urls":["https://162.253.55.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.22: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-18T15:17:36.544569Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"27.391844ms"} {"level":"info","ts":"2026-09-18T15:17:36.567055Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8608f4af3693a53b","cluster-id":"c541111188849f0e"} {"level":"info","ts":"2026-09-18T15:17:36.567212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:17:36.567242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became follower at term 0"} {"level":"info","ts":"2026-09-18T15:17:36.567274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8608f4af3693a53b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:17:36.567299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became follower at term 1"} {"level":"info","ts":"2026-09-18T15:17:36.567363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=(9658238434268128571)"} {"level":"warn","ts":"2026-09-18T15:17:36.588222Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:17:36.597567Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:17:36.60397Z","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-18T15:17:36.608007Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8608f4af3693a53b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:17:36.608138Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8608f4af3693a53b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:17:36.608313Z","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-18T15:17:36.608706Z","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-18T15:17:36.608718Z","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-18T15:17:36.610663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b switched to configuration voters=(9658238434268128571)"} {"level":"info","ts":"2026-09-18T15:17:36.610782Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c541111188849f0e","local-member-id":"8608f4af3693a53b","added-peer-id":"8608f4af3693a53b","added-peer-peer-urls":["https://162.253.55.22:2380"]} {"level":"info","ts":"2026-09-18T15:17:36.611116Z","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-18T15:17:36.611199Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.22:2380"} {"level":"info","ts":"2026-09-18T15:17:36.611224Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.22:2380"} {"level":"info","ts":"2026-09-18T15:17:36.611358Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8608f4af3693a53b","initial-advertise-peer-urls":["https://162.253.55.22:2380"],"listen-peer-urls":["https://162.253.55.22:2380"],"advertise-client-urls":["https://162.253.55.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:17:36.611397Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:17:37.46806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:17:37.468128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:17:37.468152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b received MsgPreVoteResp from 8608f4af3693a53b at term 1"} {"level":"info","ts":"2026-09-18T15:17:37.468168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:17:37.468173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b received MsgVoteResp from 8608f4af3693a53b at term 2"} {"level":"info","ts":"2026-09-18T15:17:37.468183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8608f4af3693a53b became leader at term 2"} {"level":"info","ts":"2026-09-18T15:17:37.468192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8608f4af3693a53b elected leader 8608f4af3693a53b at term 2"} {"level":"info","ts":"2026-09-18T15:17:37.474297Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8608f4af3693a53b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.22:2379]}","request-path":"/0/members/8608f4af3693a53b/attributes","cluster-id":"c541111188849f0e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:17:37.474303Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:17:37.474318Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:37.474431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:17:37.474549Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:17:37.474587Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:17:37.47742Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.22:2379"} {"level":"info","ts":"2026-09-18T15:17:37.477994Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T15:17:37.493753Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c541111188849f0e","local-member-id":"8608f4af3693a53b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:37.493937Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:37.493976Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:40.047893Z","caller":"traceutil/trace.go:171","msg":"trace[1194776874] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"191.51798ms","start":"2026-09-18T15:17:39.856344Z","end":"2026-09-18T15:17:40.047862Z","steps":["trace[1194776874] 'process raft request' (duration: 121.502121ms)","trace[1194776874] 'compare' (duration: 69.849056ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:40.060365Z","caller":"traceutil/trace.go:171","msg":"trace[1813180625] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"130.776399ms","start":"2026-09-18T15:17:39.929557Z","end":"2026-09-18T15:17:40.060333Z","steps":["trace[1813180625] 'process raft request' (duration: 130.627247ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:40.060522Z","caller":"traceutil/trace.go:171","msg":"trace[1304381600] transaction","detail":"{read_only:false; number_of_response:0; response_revision:86; }","duration":"110.041627ms","start":"2026-09-18T15:17:39.950458Z","end":"2026-09-18T15:17:40.0605Z","steps":["trace[1304381600] 'process raft request' (duration: 109.825483ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:40.206217Z","caller":"traceutil/trace.go:171","msg":"trace[907708671] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"104.890596ms","start":"2026-09-18T15:17:40.1013Z","end":"2026-09-18T15:17:40.206191Z","steps":["trace[907708671] 'process raft request' (duration: 72.178967ms)","trace[907708671] 'compare' (duration: 32.555496ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:40.468326Z","caller":"traceutil/trace.go:171","msg":"trace[1372522280] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"193.612408ms","start":"2026-09-18T15:17:40.274684Z","end":"2026-09-18T15:17:40.468296Z","steps":["trace[1372522280] 'process raft request' (duration: 104.775083ms)","trace[1372522280] 'compare' (duration: 88.678212ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:40.646506Z","caller":"traceutil/trace.go:171","msg":"trace[1494576650] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"111.649643ms","start":"2026-09-18T15:17:40.534816Z","end":"2026-09-18T15:17:40.646466Z","steps":["trace[1494576650] 'process raft request' (duration: 66.772522ms)","trace[1494576650] 'compare' (duration: 44.731908ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:41.004294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.676442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-18T15:17:41.004412Z","caller":"traceutil/trace.go:171","msg":"trace[138231634] linearizableReadLoop","detail":"{readStateIndex:105; appliedIndex:104; }","duration":"153.667293ms","start":"2026-09-18T15:17:40.850728Z","end":"2026-09-18T15:17:41.004395Z","steps":["trace[138231634] 'read index received' (duration: 37.339679ms)","trace[138231634] 'applied index is now lower than readState.Index' (duration: 116.326874ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:41.004511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.762404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T15:17:41.004535Z","caller":"traceutil/trace.go:171","msg":"trace[424303102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:100; }","duration":"153.834666ms","start":"2026-09-18T15:17:40.850693Z","end":"2026-09-18T15:17:41.004528Z","steps":["trace[424303102] 'agreement among raft nodes before linearized reading' (duration: 153.738884ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:41.004504Z","caller":"traceutil/trace.go:171","msg":"trace[774414985] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"188.693442ms","start":"2026-09-18T15:17:40.815754Z","end":"2026-09-18T15:17:41.004447Z","steps":["trace[774414985] 'process raft request' (duration: 72.43182ms)","trace[774414985] 'compare' (duration: 115.526909ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:46.825916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.332598ms","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-18T15:17:46.826062Z","caller":"traceutil/trace.go:171","msg":"trace[996918076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:298; }","duration":"100.536022ms","start":"2026-09-18T15:17:46.725493Z","end":"2026-09-18T15:17:46.826029Z","steps":["trace[996918076] 'agreement among raft nodes before linearized reading' (duration: 100.219656ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:48.972638Z","caller":"traceutil/trace.go:171","msg":"trace[1541480374] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"158.384478ms","start":"2026-09-18T15:17:48.814209Z","end":"2026-09-18T15:17:48.972594Z","steps":["trace[1541480374] 'process raft request' (duration: 109.605114ms)","trace[1541480374] 'compare' (duration: 48.561822ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:48.972716Z","caller":"traceutil/trace.go:171","msg":"trace[1514105206] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:357; }","duration":"122.95608ms","start":"2026-09-18T15:17:48.849745Z","end":"2026-09-18T15:17:48.972701Z","steps":["trace[1514105206] 'read index received' (duration: 74.020693ms)","trace[1514105206] 'applied index is now lower than readState.Index' (duration: 48.934347ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:48.97284Z","caller":"traceutil/trace.go:171","msg":"trace[628190471] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"158.133235ms","start":"2026-09-18T15:17:48.814695Z","end":"2026-09-18T15:17:48.972828Z","steps":["trace[628190471] 'process raft request' (duration: 157.910651ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:48.972904Z","caller":"traceutil/trace.go:171","msg":"trace[49737016] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"158.579033ms","start":"2026-09-18T15:17:48.814319Z","end":"2026-09-18T15:17:48.972898Z","steps":["trace[49737016] 'process raft request' (duration: 158.226128ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:48.973094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.309446ms","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-18T15:17:48.973133Z","caller":"traceutil/trace.go:171","msg":"trace[1001251873] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:347; }","duration":"123.413338ms","start":"2026-09-18T15:17:48.84971Z","end":"2026-09-18T15:17:48.973123Z","steps":["trace[1001251873] 'agreement among raft nodes before linearized reading' (duration: 123.050471ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:48.972997Z","caller":"traceutil/trace.go:171","msg":"trace[1618607764] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"154.471772ms","start":"2026-09-18T15:17:48.818461Z","end":"2026-09-18T15:17:48.972933Z","steps":["trace[1618607764] 'process raft request' (duration: 154.184547ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:48.979929Z","caller":"traceutil/trace.go:171","msg":"trace[934767939] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"126.984008ms","start":"2026-09-18T15:17:48.85293Z","end":"2026-09-18T15:17:48.979914Z","steps":["trace[934767939] 'process raft request' (duration: 126.876096ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:01.667161Z","caller":"traceutil/trace.go:171","msg":"trace[675613902] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:409; }","duration":"295.943812ms","start":"2026-09-18T15:18:01.371196Z","end":"2026-09-18T15:18:01.66714Z","steps":["trace[675613902] 'read index received' (duration: 295.77192ms)","trace[675613902] 'applied index is now lower than readState.Index' (duration: 170.762µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:01.667255Z","caller":"traceutil/trace.go:171","msg":"trace[1157930823] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"571.796078ms","start":"2026-09-18T15:18:01.095382Z","end":"2026-09-18T15:18:01.667178Z","steps":["trace[1157930823] 'process raft request' (duration: 571.647266ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:01.667308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.100825ms","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-18T15:18:01.667345Z","caller":"traceutil/trace.go:171","msg":"trace[491027055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:393; }","duration":"296.176806ms","start":"2026-09-18T15:18:01.371159Z","end":"2026-09-18T15:18:01.667336Z","steps":["trace[491027055] 'agreement among raft nodes before linearized reading' (duration: 296.096484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:01.667311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.290763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-18T15:18:01.667442Z","caller":"traceutil/trace.go:171","msg":"trace[1800728887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:393; }","duration":"292.445966ms","start":"2026-09-18T15:18:01.374976Z","end":"2026-09-18T15:18:01.667422Z","steps":["trace[1800728887] 'agreement among raft nodes before linearized reading' (duration: 292.292724ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:01.667681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:01.095361Z","time spent":"571.984361ms","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:18:01.912779Z","caller":"traceutil/trace.go:171","msg":"trace[284895755] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"242.093986ms","start":"2026-09-18T15:18:01.670652Z","end":"2026-09-18T15:18:01.912746Z","steps":["trace[284895755] 'process raft request' (duration: 230.152831ms)","trace[284895755] 'compare' (duration: 11.686181ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:01.912919Z","caller":"traceutil/trace.go:171","msg":"trace[1880944076] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"242.240098ms","start":"2026-09-18T15:18:01.670652Z","end":"2026-09-18T15:18:01.912892Z","steps":["trace[1880944076] 'process raft request' (duration: 241.985704ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:11.922623Z","caller":"traceutil/trace.go:171","msg":"trace[948501739] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"150.040767ms","start":"2026-09-18T15:18:11.772566Z","end":"2026-09-18T15:18:11.922607Z","steps":["trace[948501739] 'process raft request' (duration: 149.921106ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:27.824207Z","caller":"traceutil/trace.go:171","msg":"trace[534981508] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"109.981881ms","start":"2026-09-18T15:18:27.714199Z","end":"2026-09-18T15:18:27.82418Z","steps":["trace[534981508] 'process raft request' (duration: 63.48742ms)","trace[534981508] 'compare' (duration: 46.325239ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:28.534155Z","caller":"traceutil/trace.go:171","msg":"trace[758738460] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"175.562759ms","start":"2026-09-18T15:18:28.358568Z","end":"2026-09-18T15:18:28.53413Z","steps":["trace[758738460] 'process raft request' (duration: 120.375027ms)","trace[758738460] 'compare' (duration: 55.042789ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:28.555789Z","caller":"traceutil/trace.go:171","msg":"trace[1606048900] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"182.902171ms","start":"2026-09-18T15:18:28.372864Z","end":"2026-09-18T15:18:28.555766Z","steps":["trace[1606048900] 'process raft request' (duration: 182.830599ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:28.555922Z","caller":"traceutil/trace.go:171","msg":"trace[1535525473] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"191.182927ms","start":"2026-09-18T15:18:28.364711Z","end":"2026-09-18T15:18:28.555894Z","steps":["trace[1535525473] 'process raft request' (duration: 190.837441ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:29.115224Z","caller":"traceutil/trace.go:171","msg":"trace[979926769] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"158.331223ms","start":"2026-09-18T15:18:28.956872Z","end":"2026-09-18T15:18:29.115203Z","steps":["trace[979926769] 'read index received' (duration: 158.295752ms)","trace[979926769] 'applied index is now lower than readState.Index' (duration: 34.641µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:29.115304Z","caller":"traceutil/trace.go:171","msg":"trace[1155606578] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"163.548932ms","start":"2026-09-18T15:18:28.951727Z","end":"2026-09-18T15:18:29.115276Z","steps":["trace[1155606578] 'process raft request' (duration: 163.354459ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:29.115534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.606007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-ldtfd\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-09-18T15:18:29.11564Z","caller":"traceutil/trace.go:171","msg":"trace[666648712] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-ldtfd; range_end:; response_count:1; response_revision:615; }","duration":"158.801109ms","start":"2026-09-18T15:18:28.956821Z","end":"2026-09-18T15:18:29.115622Z","steps":["trace[666648712] 'agreement among raft nodes before linearized reading' (duration: 158.485764ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:29.84372Z","caller":"traceutil/trace.go:171","msg":"trace[297840399] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"530.859184ms","start":"2026-09-18T15:18:29.31263Z","end":"2026-09-18T15:18:29.843489Z","steps":["trace[297840399] 'process raft request' (duration: 530.530499ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:29.844655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:29.3126Z","time spent":"531.494285ms","remote":"127.0.0.1:50084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:18:29.850385Z","caller":"traceutil/trace.go:171","msg":"trace[178924632] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"350.979495ms","start":"2026-09-18T15:18:29.499371Z","end":"2026-09-18T15:18:29.850351Z","steps":["trace[178924632] 'process raft request' (duration: 350.398926ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:29.850413Z","caller":"traceutil/trace.go:171","msg":"trace[377653594] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"147.430246ms","start":"2026-09-18T15:18:29.702899Z","end":"2026-09-18T15:18:29.85033Z","steps":["trace[377653594] 'process raft request' (duration: 147.356255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:29.850624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:29.499352Z","time spent":"351.119057ms","remote":"127.0.0.1:50084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:18:33.737637Z","caller":"traceutil/trace.go:171","msg":"trace[1752707360] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"134.372371ms","start":"2026-09-18T15:18:33.603238Z","end":"2026-09-18T15:18:33.737611Z","steps":["trace[1752707360] 'process raft request' (duration: 133.874324ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:34.330172Z","caller":"traceutil/trace.go:171","msg":"trace[1102560147] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"218.351755ms","start":"2026-09-18T15:18:34.111792Z","end":"2026-09-18T15:18:34.330144Z","steps":["trace[1102560147] 'read index received' (duration: 213.740215ms)","trace[1102560147] 'applied index is now lower than readState.Index' (duration: 4.61009ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:34.330242Z","caller":"traceutil/trace.go:171","msg":"trace[2085431073] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"537.929003ms","start":"2026-09-18T15:18:33.792284Z","end":"2026-09-18T15:18:34.330213Z","steps":["trace[2085431073] 'process raft request' (duration: 533.261252ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:34.330408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.598029ms","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-09-18T15:18:34.330441Z","caller":"traceutil/trace.go:171","msg":"trace[758119347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:669; }","duration":"218.672619ms","start":"2026-09-18T15:18:34.111759Z","end":"2026-09-18T15:18:34.330432Z","steps":["trace[758119347] 'agreement among raft nodes before linearized reading' (duration: 218.504917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:34.330441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.276444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:34.330502Z","caller":"traceutil/trace.go:171","msg":"trace[1378538825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:669; }","duration":"110.338675ms","start":"2026-09-18T15:18:34.220153Z","end":"2026-09-18T15:18:34.330492Z","steps":["trace[1378538825] 'agreement among raft nodes before linearized reading' (duration: 110.259914ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:34.330491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:33.792266Z","time spent":"538.071055ms","remote":"127.0.0.1:50600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:18:38.426859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.270789ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-18T15:18:38.427014Z","caller":"traceutil/trace.go:171","msg":"trace[1003607412] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:718; }","duration":"503.556297ms","start":"2026-09-18T15:18:37.923439Z","end":"2026-09-18T15:18:38.426995Z","steps":["trace[1003607412] 'read index received' (duration: 45.351µs)","trace[1003607412] 'applied index is now lower than readState.Index' (duration: 503.509416ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:18:38.427168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.71841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tk2hp\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-18T15:18:38.427198Z","caller":"traceutil/trace.go:171","msg":"trace[220683620] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tk2hp; range_end:; response_count:1; response_revision:690; }","duration":"503.7885ms","start":"2026-09-18T15:18:37.923398Z","end":"2026-09-18T15:18:38.427187Z","steps":["trace[220683620] 'agreement among raft nodes before linearized reading' (duration: 503.689499ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:38.427247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:37.92338Z","time spent":"503.855872ms","remote":"127.0.0.1:50230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-tk2hp\" "} {"level":"warn","ts":"2026-09-18T15:18:38.4273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.780926ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:38.427344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.93241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:38.427415Z","caller":"traceutil/trace.go:171","msg":"trace[1600270441] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:690; }","duration":"540.908828ms","start":"2026-09-18T15:18:37.886485Z","end":"2026-09-18T15:18:38.427393Z","steps":["trace[1600270441] 'range keys from in-memory index tree' (duration: 540.764875ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:38.42745Z","caller":"traceutil/trace.go:171","msg":"trace[1937417056] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:690; }","duration":"251.127372ms","start":"2026-09-18T15:18:38.176299Z","end":"2026-09-18T15:18:38.427426Z","steps":["trace[1937417056] 'agreement among raft nodes before linearized reading' (duration: 250.950989ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:38.427708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.834894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:38.427731Z","caller":"traceutil/trace.go:171","msg":"trace[1280648570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"207.896815ms","start":"2026-09-18T15:18:38.219827Z","end":"2026-09-18T15:18:38.427724Z","steps":["trace[1280648570] 'agreement among raft nodes before linearized reading' (duration: 207.854084ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:38.553841Z","caller":"traceutil/trace.go:171","msg":"trace[1698826650] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"120.213741ms","start":"2026-09-18T15:18:38.433603Z","end":"2026-09-18T15:18:38.553817Z","steps":["trace[1698826650] 'process raft request' (duration: 120.042329ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:39.165796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11906286739539410120,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-18T15:18:39.666322Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11906286739539410120,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-18T15:18:39.687691Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.134001854s","expected-duration":"1s"} {"level":"info","ts":"2026-09-18T15:18:39.756139Z","caller":"traceutil/trace.go:171","msg":"trace[208983903] linearizableReadLoop","detail":"{readStateIndex:724; appliedIndex:720; }","duration":"1.090396458s","start":"2026-09-18T15:18:38.665716Z","end":"2026-09-18T15:18:39.756112Z","steps":["trace[208983903] 'read index received' (duration: 1.022171488s)","trace[208983903] 'applied index is now lower than readState.Index' (duration: 68.22388ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:39.756161Z","caller":"traceutil/trace.go:171","msg":"trace[396257309] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"1.321686333s","start":"2026-09-18T15:18:38.434446Z","end":"2026-09-18T15:18:39.756133Z","steps":["trace[396257309] 'process raft request' (duration: 1.253743648s)","trace[396257309] 'compare' (duration: 67.146084ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:39.75629Z","caller":"traceutil/trace.go:171","msg":"trace[1947164574] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"1.321776275s","start":"2026-09-18T15:18:38.434503Z","end":"2026-09-18T15:18:39.756279Z","steps":["trace[1947164574] 'process raft request' (duration: 1.321347669s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:39.756309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:38.434417Z","time spent":"1.321811206s","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:39.756409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:38.434494Z","time spent":"1.321820205s","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:18:39.75659Z","caller":"traceutil/trace.go:171","msg":"trace[717553689] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"1.322017938s","start":"2026-09-18T15:18:38.434564Z","end":"2026-09-18T15:18:39.756582Z","steps":["trace[717553689] 'process raft request' (duration: 1.321428699s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:39.75666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090942997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T15:18:39.756707Z","caller":"traceutil/trace.go:171","msg":"trace[1725846400] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:695; }","duration":"1.091031438s","start":"2026-09-18T15:18:38.665663Z","end":"2026-09-18T15:18:39.756694Z","steps":["trace[1725846400] 'agreement among raft nodes before linearized reading' (duration: 1.090919446s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:39.756738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:38.665634Z","time spent":"1.09109697s","remote":"127.0.0.1:50600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-09-18T15:18:39.756805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.536636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:39.756791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.696012ms","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-18T15:18:39.756857Z","caller":"traceutil/trace.go:171","msg":"trace[1996380355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:695; }","duration":"534.584056ms","start":"2026-09-18T15:18:39.222257Z","end":"2026-09-18T15:18:39.756841Z","steps":["trace[1996380355] 'agreement among raft nodes before linearized reading' (duration: 534.490345ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:39.756867Z","caller":"traceutil/trace.go:171","msg":"trace[151090608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:695; }","duration":"835.819194ms","start":"2026-09-18T15:18:38.921031Z","end":"2026-09-18T15:18:39.756851Z","steps":["trace[151090608] 'agreement among raft nodes before linearized reading' (duration: 835.617891ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:39.75688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:39.22219Z","time spent":"534.685858ms","remote":"127.0.0.1:50012","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-18T15:18:39.756909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:38.921014Z","time spent":"835.886795ms","remote":"127.0.0.1:50320","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-18T15:18:39.757013Z","caller":"traceutil/trace.go:171","msg":"trace[236111799] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"1.310207212s","start":"2026-09-18T15:18:38.446783Z","end":"2026-09-18T15:18:39.75699Z","steps":["trace[236111799] 'process raft request' (duration: 1.309253318s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:39.757119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:38.446761Z","time spent":"1.310304824s","remote":"127.0.0.1:50230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:39.756635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:38.434538Z","time spent":"1.3220741s","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:18:40.376847Z","caller":"traceutil/trace.go:171","msg":"trace[174120605] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"614.29962ms","start":"2026-09-18T15:18:39.762514Z","end":"2026-09-18T15:18:40.376813Z","steps":["trace[174120605] 'process raft request' (duration: 518.276356ms)","trace[174120605] 'compare' (duration: 95.608728ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:18:40.377085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:39.76249Z","time spent":"614.478673ms","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:58.942082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.151299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:58.941844Z","caller":"traceutil/trace.go:171","msg":"trace[1218859982] linearizableReadLoop","detail":"{readStateIndex:852; appliedIndex:851; }","duration":"348.918416ms","start":"2026-09-18T15:18:58.592905Z","end":"2026-09-18T15:18:58.941823Z","steps":["trace[1218859982] 'read index received' (duration: 348.706103ms)","trace[1218859982] 'applied index is now lower than readState.Index' (duration: 211.393µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:58.942146Z","caller":"traceutil/trace.go:171","msg":"trace[1375098842] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:817; }","duration":"349.2753ms","start":"2026-09-18T15:18:58.592858Z","end":"2026-09-18T15:18:58.942133Z","steps":["trace[1375098842] 'agreement among raft nodes before linearized reading' (duration: 349.164679ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:58.941948Z","caller":"traceutil/trace.go:171","msg":"trace[435178023] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"481.732958ms","start":"2026-09-18T15:18:58.460183Z","end":"2026-09-18T15:18:58.941916Z","steps":["trace[435178023] 'process raft request' (duration: 481.514595ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:58.942182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:58.592833Z","time spent":"349.337122ms","remote":"127.0.0.1:50118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-09-18T15:18:58.942434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:58.460152Z","time spent":"482.018352ms","remote":"127.0.0.1:50320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:58.942565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.626933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T15:18:58.942594Z","caller":"traceutil/trace.go:171","msg":"trace[2116542450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"269.695173ms","start":"2026-09-18T15:18:58.672892Z","end":"2026-09-18T15:18:58.942587Z","steps":["trace[2116542450] 'agreement among raft nodes before linearized reading' (duration: 269.586262ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:00.671995Z","caller":"traceutil/trace.go:171","msg":"trace[1592741238] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"115.65015ms","start":"2026-09-18T15:20:00.556316Z","end":"2026-09-18T15:20:00.671966Z","steps":["trace[1592741238] 'process raft request' (duration: 115.491034ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:18.70306Z","caller":"traceutil/trace.go:171","msg":"trace[1444694948] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"108.07301ms","start":"2026-09-18T15:20:18.594965Z","end":"2026-09-18T15:20:18.703038Z","steps":["trace[1444694948] 'process raft request' (duration: 86.404003ms)","trace[1444694948] 'compare' (duration: 21.091456ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:20:20.615835Z","caller":"traceutil/trace.go:171","msg":"trace[419427124] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"139.113619ms","start":"2026-09-18T15:20:20.476686Z","end":"2026-09-18T15:20:20.6158Z","steps":["trace[419427124] 'process raft request' (duration: 138.817389ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:33.093066Z","caller":"traceutil/trace.go:171","msg":"trace[1209355360] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"226.397857ms","start":"2026-09-18T15:20:32.866638Z","end":"2026-09-18T15:20:33.093036Z","steps":["trace[1209355360] 'process raft request' (duration: 226.275122ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:33.093148Z","caller":"traceutil/trace.go:171","msg":"trace[1952011150] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"247.404008ms","start":"2026-09-18T15:20:32.84565Z","end":"2026-09-18T15:20:33.093054Z","steps":["trace[1952011150] 'process raft request' (duration: 180.969849ms)","trace[1952011150] 'compare' (duration: 66.050446ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:20:35.049409Z","caller":"traceutil/trace.go:171","msg":"trace[498225390] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"169.67991ms","start":"2026-09-18T15:20:34.879709Z","end":"2026-09-18T15:20:35.049389Z","steps":["trace[498225390] 'process raft request' (duration: 169.559106ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:36.167127Z","caller":"traceutil/trace.go:171","msg":"trace[921622166] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"126.183872ms","start":"2026-09-18T15:20:36.040903Z","end":"2026-09-18T15:20:36.167087Z","steps":["trace[921622166] 'process raft request' (duration: 101.744378ms)","trace[921622166] 'compare' (duration: 24.262099ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:20:40.170272Z","caller":"traceutil/trace.go:171","msg":"trace[316330135] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"113.274706ms","start":"2026-09-18T15:20:40.056964Z","end":"2026-09-18T15:20:40.170239Z","steps":["trace[316330135] 'process raft request' (duration: 113.031508ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:29.740635Z","caller":"traceutil/trace.go:171","msg":"trace[297427883] linearizableReadLoop","detail":"{readStateIndex:1556; appliedIndex:1555; }","duration":"107.312614ms","start":"2026-09-18T15:21:29.633291Z","end":"2026-09-18T15:21:29.740603Z","steps":["trace[297427883] 'read index received' (duration: 10.752488ms)","trace[297427883] 'applied index is now lower than readState.Index' (duration: 96.558766ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:29.741099Z","caller":"traceutil/trace.go:171","msg":"trace[451553235] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"111.785288ms","start":"2026-09-18T15:21:29.629258Z","end":"2026-09-18T15:21:29.741044Z","steps":["trace[451553235] 'process raft request' (duration: 106.009978ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:29.74139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.042414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/\" range_end:\"/registry/pods/kube-system0\" limit:500 ","response":"range_response_count:10 size:65230"} {"level":"info","ts":"2026-09-18T15:21:29.741517Z","caller":"traceutil/trace.go:171","msg":"trace[1814142311] range","detail":"{range_begin:/registry/pods/kube-system/; range_end:/registry/pods/kube-system0; response_count:10; response_revision:1487; }","duration":"108.232489ms","start":"2026-09-18T15:21:29.63326Z","end":"2026-09-18T15:21:29.741492Z","steps":["trace[1814142311] 'agreement among raft nodes before linearized reading' (duration: 107.707804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:29.7416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.729807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:69 size:51159"} {"level":"info","ts":"2026-09-18T15:21:29.741645Z","caller":"traceutil/trace.go:171","msg":"trace[1606732267] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:69; response_revision:1487; }","duration":"107.818939ms","start":"2026-09-18T15:21:29.633815Z","end":"2026-09-18T15:21:29.741634Z","steps":["trace[1606732267] 'agreement among raft nodes before linearized reading' (duration: 107.246063ms)"],"step_count":1}