{"level":"warn","ts":"2026-05-20T02:14:02.900942Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T02:14:02.901048Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-05-20T02:14:02.901158Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-20T02:14:02.901172Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-20T02:14:02.901273Z","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-05-20T02:14:02.902086Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-05-20T02:14:02.902216Z","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://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-05-20T02:14:02.907945Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.461737ms"} {"level":"info","ts":"2026-05-20T02:14:02.917354Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-05-20T02:14:02.917443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-05-20T02:14:02.917474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-05-20T02:14:02.917488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-20T02:14:02.917504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-05-20T02:14:02.917544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-05-20T02:14:02.923701Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-20T02:14:02.925168Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-20T02:14:02.926299Z","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-05-20T02:14:02.928413Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-20T02:14:02.928891Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-20T02:14:02.929054Z","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-05-20T02:14:02.9291Z","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-05-20T02:14:02.929338Z","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-05-20T02:14:02.931755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-05-20T02:14:02.933366Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-20T02:14:02.934935Z","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-05-20T02:14:02.935098Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-20T02:14:02.935154Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-20T02:14:02.93547Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-20T02:14:02.935413Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-20T02:14:03.917965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-05-20T02:14:03.918052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-20T02:14:03.918114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-05-20T02:14:03.918137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-05-20T02:14:03.918149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-20T02:14:03.918165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-05-20T02:14:03.918179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-20T02:14:03.949415Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-05-20T02:14:03.949484Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T02:14:03.949533Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:14:03.949438Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-20T02:14:03.949807Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-20T02:14:03.949838Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-20T02:14:03.951922Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-20T02:14:03.956898Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-05-20T02:14:03.971723Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:14:03.971828Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:14:03.971857Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-20T02:14:05.315087Z","caller":"traceutil/trace.go:171","msg":"trace[564458038] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"126.436682ms","start":"2026-05-20T02:14:05.188623Z","end":"2026-05-20T02:14:05.315059Z","steps":["trace[564458038] 'process raft request' (duration: 126.134196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:05.315273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.480159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T02:14:05.31535Z","caller":"traceutil/trace.go:171","msg":"trace[710406378] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"115.586254ms","start":"2026-05-20T02:14:05.199755Z","end":"2026-05-20T02:14:05.315341Z","steps":["trace[710406378] 'agreement among raft nodes before linearized reading' (duration: 115.440507ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:05.315141Z","caller":"traceutil/trace.go:171","msg":"trace[967088052] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"115.336681ms","start":"2026-05-20T02:14:05.199777Z","end":"2026-05-20T02:14:05.315114Z","steps":["trace[967088052] 'read index received' (duration: 83.470537ms)","trace[967088052] 'applied index is now lower than readState.Index' (duration: 31.865334ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:06.350141Z","caller":"traceutil/trace.go:171","msg":"trace[318907314] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"164.748671ms","start":"2026-05-20T02:14:06.185365Z","end":"2026-05-20T02:14:06.350113Z","steps":["trace[318907314] 'read index received' (duration: 97.346366ms)","trace[318907314] 'applied index is now lower than readState.Index' (duration: 67.401055ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:06.350214Z","caller":"traceutil/trace.go:171","msg":"trace[1596155089] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"165.050037ms","start":"2026-05-20T02:14:06.185128Z","end":"2026-05-20T02:14:06.350178Z","steps":["trace[1596155089] 'process raft request' (duration: 97.573878ms)","trace[1596155089] 'compare' (duration: 67.235696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:06.350378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.987284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T02:14:06.35046Z","caller":"traceutil/trace.go:171","msg":"trace[773723870] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:72; }","duration":"165.09617ms","start":"2026-05-20T02:14:06.185349Z","end":"2026-05-20T02:14:06.350445Z","steps":["trace[773723870] 'agreement among raft nodes before linearized reading' (duration: 164.907709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:06.350389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.752739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T02:14:06.350604Z","caller":"traceutil/trace.go:171","msg":"trace[1288185646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"101.017123ms","start":"2026-05-20T02:14:06.249565Z","end":"2026-05-20T02:14:06.350582Z","steps":["trace[1288185646] 'agreement among raft nodes before linearized reading' (duration: 100.741568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:06.639497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.933623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-20T02:14:06.639595Z","caller":"traceutil/trace.go:171","msg":"trace[1426350960] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"232.469884ms","start":"2026-05-20T02:14:06.407112Z","end":"2026-05-20T02:14:06.639582Z","steps":["trace[1426350960] 'process raft request' (duration: 97.979321ms)","trace[1426350960] 'compare' (duration: 133.805116ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:06.808269Z","caller":"traceutil/trace.go:171","msg":"trace[2109091968] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"164.202812ms","start":"2026-05-20T02:14:06.644041Z","end":"2026-05-20T02:14:06.808244Z","steps":["trace[2109091968] 'process raft request' (duration: 159.076538ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:07.022637Z","caller":"traceutil/trace.go:171","msg":"trace[525658171] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"174.162154ms","start":"2026-05-20T02:14:06.848437Z","end":"2026-05-20T02:14:07.0226Z","steps":["trace[525658171] 'process raft request' (duration: 81.040885ms)","trace[525658171] 'compare' (duration: 92.989832ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:07.288696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.27052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-20T02:14:07.288904Z","caller":"traceutil/trace.go:171","msg":"trace[364441487] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"184.726875ms","start":"2026-05-20T02:14:07.104145Z","end":"2026-05-20T02:14:07.288871Z","steps":["trace[364441487] 'process raft request' (duration: 39.210863ms)","trace[364441487] 'compare' (duration: 145.168174ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:07.507622Z","caller":"traceutil/trace.go:171","msg":"trace[1423450221] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"118.937667ms","start":"2026-05-20T02:14:07.388657Z","end":"2026-05-20T02:14:07.507595Z","steps":["trace[1423450221] 'process raft request' (duration: 38.475414ms)","trace[1423450221] 'compare' (duration: 80.072633ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:07.844509Z","caller":"traceutil/trace.go:171","msg":"trace[1186512653] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"331.563408ms","start":"2026-05-20T02:14:07.512909Z","end":"2026-05-20T02:14:07.844472Z","steps":["trace[1186512653] 'process raft request' (duration: 232.757414ms)","trace[1186512653] 'compare' (duration: 98.661736ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:07.844691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:07.512889Z","time spent":"331.707095ms","remote":"127.0.0.1:34762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:08.042592Z","caller":"traceutil/trace.go:171","msg":"trace[1227370553] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"125.992316ms","start":"2026-05-20T02:14:07.916571Z","end":"2026-05-20T02:14:08.042563Z","steps":["trace[1227370553] 'process raft request' (duration: 52.533017ms)","trace[1227370553] 'compare' (duration: 73.312611ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:08.526862Z","caller":"traceutil/trace.go:171","msg":"trace[1897259339] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"128.414509ms","start":"2026-05-20T02:14:08.398427Z","end":"2026-05-20T02:14:08.526842Z","steps":["trace[1897259339] 'process raft request' (duration: 61.204268ms)","trace[1897259339] 'compare' (duration: 67.106666ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:08.530022Z","caller":"traceutil/trace.go:171","msg":"trace[1677887846] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"103.563371ms","start":"2026-05-20T02:14:08.42645Z","end":"2026-05-20T02:14:08.530013Z","steps":["trace[1677887846] 'process raft request' (duration: 103.478177ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:08.690925Z","caller":"traceutil/trace.go:171","msg":"trace[2113464454] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"101.922105ms","start":"2026-05-20T02:14:08.588986Z","end":"2026-05-20T02:14:08.690908Z","steps":["trace[2113464454] 'process raft request' (duration: 101.890694ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:08.691017Z","caller":"traceutil/trace.go:171","msg":"trace[1081785592] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"103.426865ms","start":"2026-05-20T02:14:08.587523Z","end":"2026-05-20T02:14:08.69095Z","steps":["trace[1081785592] 'process raft request' (duration: 50.045825ms)","trace[1081785592] 'compare' (duration: 53.210421ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:08.901087Z","caller":"traceutil/trace.go:171","msg":"trace[1512128714] linearizableReadLoop","detail":"{readStateIndex:115; appliedIndex:114; }","duration":"152.696899ms","start":"2026-05-20T02:14:08.74835Z","end":"2026-05-20T02:14:08.901047Z","steps":["trace[1512128714] 'read index received' (duration: 84.034131ms)","trace[1512128714] 'applied index is now lower than readState.Index' (duration: 68.661688ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:08.901125Z","caller":"traceutil/trace.go:171","msg":"trace[724456994] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"204.850794ms","start":"2026-05-20T02:14:08.696241Z","end":"2026-05-20T02:14:08.901092Z","steps":["trace[724456994] 'process raft request' (duration: 136.170366ms)","trace[724456994] 'compare' (duration: 68.502269ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:08.901397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.017306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b1244d1859ba83\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-05-20T02:14:08.901446Z","caller":"traceutil/trace.go:171","msg":"trace[2041992000] range","detail":"{range_begin:/registry/events/default/instance.18b1244d1859ba83; range_end:; response_count:1; response_revision:110; }","duration":"153.146062ms","start":"2026-05-20T02:14:08.748286Z","end":"2026-05-20T02:14:08.901432Z","steps":["trace[2041992000] 'agreement among raft nodes before linearized reading' (duration: 152.887539ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:09.021686Z","caller":"traceutil/trace.go:171","msg":"trace[840301587] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"113.91711ms","start":"2026-05-20T02:14:08.907723Z","end":"2026-05-20T02:14:09.02164Z","steps":["trace[840301587] 'process raft request' (duration: 98.599789ms)","trace[840301587] 'compare' (duration: 15.11497ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:09.337806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.570326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-20T02:14:09.337911Z","caller":"traceutil/trace.go:171","msg":"trace[558690373] linearizableReadLoop","detail":"{readStateIndex:122; appliedIndex:121; }","duration":"249.346188ms","start":"2026-05-20T02:14:09.088548Z","end":"2026-05-20T02:14:09.337895Z","steps":["trace[558690373] 'read index received' (duration: 44.572312ms)","trace[558690373] 'applied index is now lower than readState.Index' (duration: 204.772756ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:09.338112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.55663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b1244d1859ba83\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-05-20T02:14:09.338222Z","caller":"traceutil/trace.go:171","msg":"trace[2101009742] range","detail":"{range_begin:/registry/events/default/instance.18b1244d1859ba83; range_end:; response_count:1; response_revision:117; }","duration":"249.636874ms","start":"2026-05-20T02:14:09.088512Z","end":"2026-05-20T02:14:09.338149Z","steps":["trace[2101009742] 'agreement among raft nodes before linearized reading' (duration: 249.426533ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:09.338237Z","caller":"traceutil/trace.go:171","msg":"trace[1914381141] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"249.778961ms","start":"2026-05-20T02:14:09.088446Z","end":"2026-05-20T02:14:09.338225Z","steps":["trace[1914381141] 'process raft request' (duration: 44.708879ms)","trace[1914381141] 'compare' (duration: 204.44924ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:09.529564Z","caller":"traceutil/trace.go:171","msg":"trace[1725225076] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"102.879684ms","start":"2026-05-20T02:14:09.426661Z","end":"2026-05-20T02:14:09.529541Z","steps":["trace[1725225076] 'process raft request' (duration: 63.927512ms)","trace[1725225076] 'compare' (duration: 38.742071ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:09.529797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.692201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T02:14:09.530014Z","caller":"traceutil/trace.go:171","msg":"trace[1493786053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:119; }","duration":"179.797517ms","start":"2026-05-20T02:14:09.350033Z","end":"2026-05-20T02:14:09.52983Z","steps":["trace[1493786053] 'agreement among raft nodes before linearized reading' (duration: 179.676541ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:09.598037Z","caller":"traceutil/trace.go:171","msg":"trace[523291921] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"143.8424ms","start":"2026-05-20T02:14:09.454176Z","end":"2026-05-20T02:14:09.598018Z","steps":["trace[523291921] 'process raft request' (duration: 143.635049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:09.59807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.655143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b1244d1859db71\" ","response":"range_response_count:1 size:650"} {"level":"warn","ts":"2026-05-20T02:14:09.598093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.812573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-20T02:14:09.598154Z","caller":"traceutil/trace.go:171","msg":"trace[723613556] range","detail":"{range_begin:/registry/events/default/instance.18b1244d1859db71; range_end:; response_count:1; response_revision:120; }","duration":"145.771789ms","start":"2026-05-20T02:14:09.452361Z","end":"2026-05-20T02:14:09.598132Z","steps":["trace[723613556] 'agreement among raft nodes before linearized reading' (duration: 145.581099ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:09.598187Z","caller":"traceutil/trace.go:171","msg":"trace[530929374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:120; }","duration":"146.946601ms","start":"2026-05-20T02:14:09.451217Z","end":"2026-05-20T02:14:09.598164Z","steps":["trace[530929374] 'agreement among raft nodes before linearized reading' (duration: 146.74618ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:10.019661Z","caller":"traceutil/trace.go:171","msg":"trace[773362726] linearizableReadLoop","detail":"{readStateIndex:133; appliedIndex:132; }","duration":"228.470579ms","start":"2026-05-20T02:14:09.791155Z","end":"2026-05-20T02:14:10.019626Z","steps":["trace[773362726] 'read index received' (duration: 143.398476ms)","trace[773362726] 'applied index is now lower than readState.Index' (duration: 85.070872ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:10.019822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.642377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b1244d1859db71\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-05-20T02:14:10.019749Z","caller":"traceutil/trace.go:171","msg":"trace[1727563534] transaction","detail":"{read_only:false; response_revision:128; number_of_response:1; }","duration":"229.004047ms","start":"2026-05-20T02:14:09.790703Z","end":"2026-05-20T02:14:10.019707Z","steps":["trace[1727563534] 'process raft request' (duration: 143.904863ms)","trace[1727563534] 'compare' (duration: 84.677812ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:10.019897Z","caller":"traceutil/trace.go:171","msg":"trace[1668543273] range","detail":"{range_begin:/registry/events/default/instance.18b1244d1859db71; range_end:; response_count:1; response_revision:128; }","duration":"228.729963ms","start":"2026-05-20T02:14:09.79115Z","end":"2026-05-20T02:14:10.01988Z","steps":["trace[1668543273] 'agreement among raft nodes before linearized reading' (duration: 228.571304ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:10.205843Z","caller":"traceutil/trace.go:171","msg":"trace[1344993375] linearizableReadLoop","detail":"{readStateIndex:135; appliedIndex:133; }","duration":"183.293529ms","start":"2026-05-20T02:14:10.022517Z","end":"2026-05-20T02:14:10.205811Z","steps":["trace[1344993375] 'read index received' (duration: 143.088016ms)","trace[1344993375] 'applied index is now lower than readState.Index' (duration: 40.201053ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:10.205965Z","caller":"traceutil/trace.go:171","msg":"trace[277019163] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"183.965263ms","start":"2026-05-20T02:14:10.021954Z","end":"2026-05-20T02:14:10.20592Z","steps":["trace[277019163] 'process raft request' (duration: 183.776934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:10.206102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.552491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:10.206191Z","caller":"traceutil/trace.go:171","msg":"trace[738363890] range","detail":"{range_begin:/registry/clusterroles/system:controller:endpoint-controller; range_end:; response_count:0; response_revision:130; }","duration":"183.70703ms","start":"2026-05-20T02:14:10.022462Z","end":"2026-05-20T02:14:10.206169Z","steps":["trace[738363890] 'agreement among raft nodes before linearized reading' (duration: 183.461748ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:10.205901Z","caller":"traceutil/trace.go:171","msg":"trace[1471601735] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"195.701813ms","start":"2026-05-20T02:14:10.010143Z","end":"2026-05-20T02:14:10.205845Z","steps":["trace[1471601735] 'process raft request' (duration: 155.443577ms)","trace[1471601735] 'compare' (duration: 39.927729ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:10.431844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.759104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:10.432046Z","caller":"traceutil/trace.go:171","msg":"trace[1805848553] transaction","detail":"{read_only:false; response_revision:132; number_of_response:1; }","duration":"220.604623ms","start":"2026-05-20T02:14:10.211425Z","end":"2026-05-20T02:14:10.432029Z","steps":["trace[1805848553] 'process raft request' (duration: 220.53311ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:10.432114Z","caller":"traceutil/trace.go:171","msg":"trace[1398627074] linearizableReadLoop","detail":"{readStateIndex:136; appliedIndex:135; }","duration":"222.201506ms","start":"2026-05-20T02:14:10.209837Z","end":"2026-05-20T02:14:10.432038Z","steps":["trace[1398627074] 'read index received' (duration: 121.191619ms)","trace[1398627074] 'applied index is now lower than readState.Index' (duration: 101.002716ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:10.432246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.410066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b1244d1859f593\" ","response":"range_response_count:1 size:649"} {"level":"info","ts":"2026-05-20T02:14:10.432301Z","caller":"traceutil/trace.go:171","msg":"trace[640728782] range","detail":"{range_begin:/registry/events/default/instance.18b1244d1859f593; range_end:; response_count:1; response_revision:132; }","duration":"222.511482ms","start":"2026-05-20T02:14:10.20978Z","end":"2026-05-20T02:14:10.432292Z","steps":["trace[640728782] 'agreement among raft nodes before linearized reading' (duration: 222.414647ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:10.432602Z","caller":"traceutil/trace.go:171","msg":"trace[2043601632] transaction","detail":"{read_only:false; response_revision:131; number_of_response:1; }","duration":"223.26464ms","start":"2026-05-20T02:14:10.209322Z","end":"2026-05-20T02:14:10.432587Z","steps":["trace[2043601632] 'process raft request' (duration: 121.685324ms)","trace[2043601632] 'compare' (duration: 100.583855ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:10.704111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.958831ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:10.704339Z","caller":"traceutil/trace.go:171","msg":"trace[1478835470] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"212.831776ms","start":"2026-05-20T02:14:10.491412Z","end":"2026-05-20T02:14:10.704244Z","steps":["trace[1478835470] 'process raft request' (duration: 86.636903ms)","trace[1478835470] 'compare' (duration: 125.709199ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:10.706859Z","caller":"traceutil/trace.go:171","msg":"trace[1958396099] transaction","detail":"{read_only:false; response_revision:135; number_of_response:1; }","duration":"213.192446ms","start":"2026-05-20T02:14:10.49362Z","end":"2026-05-20T02:14:10.706813Z","steps":["trace[1958396099] 'process raft request' (duration: 213.011066ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:10.928199Z","caller":"traceutil/trace.go:171","msg":"trace[511038430] linearizableReadLoop","detail":"{readStateIndex:144; appliedIndex:143; }","duration":"129.643659ms","start":"2026-05-20T02:14:10.798525Z","end":"2026-05-20T02:14:10.928169Z","steps":["trace[511038430] 'read index received' (duration: 63.754795ms)","trace[511038430] 'applied index is now lower than readState.Index' (duration: 65.887574ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:10.928271Z","caller":"traceutil/trace.go:171","msg":"trace[832147779] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"173.347451ms","start":"2026-05-20T02:14:10.754874Z","end":"2026-05-20T02:14:10.928222Z","steps":["trace[832147779] 'process raft request' (duration: 107.52271ms)","trace[832147779] 'compare' (duration: 65.633231ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:10.928471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.909173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:10.928569Z","caller":"traceutil/trace.go:171","msg":"trace[587553844] range","detail":"{range_begin:/registry/clusterroles/system:controller:ephemeral-volume-controller; range_end:; response_count:0; response_revision:139; }","duration":"130.05716ms","start":"2026-05-20T02:14:10.798484Z","end":"2026-05-20T02:14:10.928541Z","steps":["trace[587553844] 'agreement among raft nodes before linearized reading' (duration: 129.8471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:11.190132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.515135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:11.190253Z","caller":"traceutil/trace.go:171","msg":"trace[1096500323] linearizableReadLoop","detail":"{readStateIndex:145; appliedIndex:144; }","duration":"257.722489ms","start":"2026-05-20T02:14:10.932512Z","end":"2026-05-20T02:14:11.190234Z","steps":["trace[1096500323] 'read index received' (duration: 152.950821ms)","trace[1096500323] 'applied index is now lower than readState.Index' (duration: 104.770508ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:11.190296Z","caller":"traceutil/trace.go:171","msg":"trace[154404310] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"258.069067ms","start":"2026-05-20T02:14:10.932204Z","end":"2026-05-20T02:14:11.190273Z","steps":["trace[154404310] 'process raft request' (duration: 153.336531ms)","trace[154404310] 'compare' (duration: 104.372258ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:11.19036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.840265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b1244d1859ba83\" ","response":"range_response_count:1 size:656"} {"level":"info","ts":"2026-05-20T02:14:11.190394Z","caller":"traceutil/trace.go:171","msg":"trace[741343311] range","detail":"{range_begin:/registry/events/default/instance.18b1244d1859ba83; range_end:; response_count:1; response_revision:140; }","duration":"257.901949ms","start":"2026-05-20T02:14:10.932483Z","end":"2026-05-20T02:14:11.190385Z","steps":["trace[741343311] 'agreement among raft nodes before linearized reading' (duration: 257.801164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:11.472995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.703141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:11.473295Z","caller":"traceutil/trace.go:171","msg":"trace[2036226720] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"243.68052ms","start":"2026-05-20T02:14:11.229589Z","end":"2026-05-20T02:14:11.47327Z","steps":["trace[2036226720] 'process raft request' (duration: 105.624862ms)","trace[2036226720] 'compare' (duration: 137.542652ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:11.473847Z","caller":"traceutil/trace.go:171","msg":"trace[1427367448] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"242.920882ms","start":"2026-05-20T02:14:11.230902Z","end":"2026-05-20T02:14:11.473823Z","steps":["trace[1427367448] 'process raft request' (duration: 242.208906ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:11.632023Z","caller":"traceutil/trace.go:171","msg":"trace[1620079015] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"138.072439ms","start":"2026-05-20T02:14:11.493925Z","end":"2026-05-20T02:14:11.631998Z","steps":["trace[1620079015] 'process raft request' (duration: 137.923622ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:11.632155Z","caller":"traceutil/trace.go:171","msg":"trace[1313644077] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"149.16265ms","start":"2026-05-20T02:14:11.482939Z","end":"2026-05-20T02:14:11.632101Z","steps":["trace[1313644077] 'process raft request' (duration: 134.832746ms)","trace[1313644077] 'compare' (duration: 13.965745ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:11.845033Z","caller":"traceutil/trace.go:171","msg":"trace[1269173288] linearizableReadLoop","detail":"{readStateIndex:159; appliedIndex:158; }","duration":"123.956056ms","start":"2026-05-20T02:14:11.721035Z","end":"2026-05-20T02:14:11.844991Z","steps":["trace[1269173288] 'read index received' (duration: 61.929036ms)","trace[1269173288] 'applied index is now lower than readState.Index' (duration: 62.02525ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:11.84509Z","caller":"traceutil/trace.go:171","msg":"trace[1745171190] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"124.197889ms","start":"2026-05-20T02:14:11.720832Z","end":"2026-05-20T02:14:11.845029Z","steps":["trace[1745171190] 'process raft request' (duration: 62.140577ms)","trace[1745171190] 'compare' (duration: 61.802209ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:11.845254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.169768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:11.845333Z","caller":"traceutil/trace.go:171","msg":"trace[437179157] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:0; response_revision:154; }","duration":"124.284674ms","start":"2026-05-20T02:14:11.721031Z","end":"2026-05-20T02:14:11.845316Z","steps":["trace[437179157] 'agreement among raft nodes before linearized reading' (duration: 124.079293ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:11.846885Z","caller":"traceutil/trace.go:171","msg":"trace[1973743439] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"122.153265ms","start":"2026-05-20T02:14:11.724699Z","end":"2026-05-20T02:14:11.846852Z","steps":["trace[1973743439] 'process raft request' (duration: 122.002128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:12.711666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.575947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:12.711787Z","caller":"traceutil/trace.go:171","msg":"trace[1327405904] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"179.992793ms","start":"2026-05-20T02:14:12.531774Z","end":"2026-05-20T02:14:12.711767Z","steps":["trace[1327405904] 'process raft request' (duration: 59.235776ms)","trace[1327405904] 'compare' (duration: 120.415379ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:13.169076Z","caller":"traceutil/trace.go:171","msg":"trace[1656937339] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"139.64074ms","start":"2026-05-20T02:14:13.029405Z","end":"2026-05-20T02:14:13.169046Z","steps":["trace[1656937339] 'process raft request' (duration: 64.631619ms)","trace[1656937339] 'compare' (duration: 74.724227ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:15.294422Z","caller":"traceutil/trace.go:171","msg":"trace[1805934649] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:278; }","duration":"148.243861ms","start":"2026-05-20T02:14:15.146154Z","end":"2026-05-20T02:14:15.294398Z","steps":["trace[1805934649] 'read index received' (duration: 130.911525ms)","trace[1805934649] 'applied index is now lower than readState.Index' (duration: 17.331466ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:15.29447Z","caller":"traceutil/trace.go:171","msg":"trace[1286997453] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"148.369007ms","start":"2026-05-20T02:14:15.146064Z","end":"2026-05-20T02:14:15.294433Z","steps":["trace[1286997453] 'process raft request' (duration: 130.990198ms)","trace[1286997453] 'compare' (duration: 17.090105ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:15.294543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.371777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:15.294571Z","caller":"traceutil/trace.go:171","msg":"trace[121306909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:273; }","duration":"148.452311ms","start":"2026-05-20T02:14:15.146109Z","end":"2026-05-20T02:14:15.294561Z","steps":["trace[121306909] 'agreement among raft nodes before linearized reading' (duration: 148.376658ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:15.306604Z","caller":"traceutil/trace.go:171","msg":"trace[1527924231] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"157.790201ms","start":"2026-05-20T02:14:15.148793Z","end":"2026-05-20T02:14:15.306583Z","steps":["trace[1527924231] 'process raft request' (duration: 157.708597ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:15.306887Z","caller":"traceutil/trace.go:171","msg":"trace[1794551508] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"160.477911ms","start":"2026-05-20T02:14:15.146398Z","end":"2026-05-20T02:14:15.306876Z","steps":["trace[1794551508] 'process raft request' (duration: 160.005788ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:15.655278Z","caller":"traceutil/trace.go:171","msg":"trace[1423023877] linearizableReadLoop","detail":"{readStateIndex:288; appliedIndex:287; }","duration":"114.779747ms","start":"2026-05-20T02:14:15.540475Z","end":"2026-05-20T02:14:15.655255Z","steps":["trace[1423023877] 'read index received' (duration: 25.627567ms)","trace[1423023877] 'applied index is now lower than readState.Index' (duration: 89.15107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:15.655407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.916883ms","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-05-20T02:14:15.655436Z","caller":"traceutil/trace.go:171","msg":"trace[1620597378] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:282; }","duration":"115.000358ms","start":"2026-05-20T02:14:15.540428Z","end":"2026-05-20T02:14:15.655428Z","steps":["trace[1620597378] 'agreement among raft nodes before linearized reading' (duration: 114.914554ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:15.655399Z","caller":"traceutil/trace.go:171","msg":"trace[1947150153] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"125.878583ms","start":"2026-05-20T02:14:15.529486Z","end":"2026-05-20T02:14:15.655364Z","steps":["trace[1947150153] 'process raft request' (duration: 36.641098ms)","trace[1947150153] 'compare' (duration: 88.963011ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:15.884771Z","caller":"traceutil/trace.go:171","msg":"trace[1246831255] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"131.718934ms","start":"2026-05-20T02:14:15.753033Z","end":"2026-05-20T02:14:15.884752Z","steps":["trace[1246831255] 'process raft request' (duration: 70.516571ms)","trace[1246831255] 'compare' (duration: 60.801533ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:15.884883Z","caller":"traceutil/trace.go:171","msg":"trace[1762525214] linearizableReadLoop","detail":"{readStateIndex:294; appliedIndex:293; }","duration":"129.619613ms","start":"2026-05-20T02:14:15.755257Z","end":"2026-05-20T02:14:15.884877Z","steps":["trace[1762525214] 'read index received' (duration: 68.246832ms)","trace[1762525214] 'applied index is now lower than readState.Index' (duration: 61.372161ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:15.885022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.757999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:15.885051Z","caller":"traceutil/trace.go:171","msg":"trace[1215948532] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:289; }","duration":"129.820683ms","start":"2026-05-20T02:14:15.755223Z","end":"2026-05-20T02:14:15.885043Z","steps":["trace[1215948532] 'agreement among raft nodes before linearized reading' (duration: 129.749209ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:16.387531Z","caller":"traceutil/trace.go:171","msg":"trace[1456432966] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"138.447284ms","start":"2026-05-20T02:14:16.249063Z","end":"2026-05-20T02:14:16.387511Z","steps":["trace[1456432966] 'process raft request' (duration: 138.407262ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:16.387569Z","caller":"traceutil/trace.go:171","msg":"trace[1652600347] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"141.038577ms","start":"2026-05-20T02:14:16.246517Z","end":"2026-05-20T02:14:16.387555Z","steps":["trace[1652600347] 'process raft request' (duration: 105.46549ms)","trace[1652600347] 'compare' (duration: 35.162747ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:16.565328Z","caller":"traceutil/trace.go:171","msg":"trace[1650646335] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:326; }","duration":"127.284102ms","start":"2026-05-20T02:14:16.438018Z","end":"2026-05-20T02:14:16.565302Z","steps":["trace[1650646335] 'read index received' (duration: 107.286348ms)","trace[1650646335] 'applied index is now lower than readState.Index' (duration: 19.996174ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:16.565466Z","caller":"traceutil/trace.go:171","msg":"trace[1682299787] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"134.875633ms","start":"2026-05-20T02:14:16.430547Z","end":"2026-05-20T02:14:16.565422Z","steps":["trace[1682299787] 'process raft request' (duration: 114.767384ms)","trace[1682299787] 'compare' (duration: 19.806315ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:16.565616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.571725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:16.56649Z","caller":"traceutil/trace.go:171","msg":"trace[274355450] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:0; response_revision:316; }","duration":"127.805996ms","start":"2026-05-20T02:14:16.437987Z","end":"2026-05-20T02:14:16.565793Z","steps":["trace[274355450] 'agreement among raft nodes before linearized reading' (duration: 127.47322ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:16.987966Z","caller":"traceutil/trace.go:171","msg":"trace[326267124] transaction","detail":"{read_only:false; number_of_response:0; response_revision:323; }","duration":"116.302448ms","start":"2026-05-20T02:14:16.871629Z","end":"2026-05-20T02:14:16.987932Z","steps":["trace[326267124] 'process raft request' (duration: 70.413889ms)","trace[326267124] 'compare' (duration: 45.808035ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:17.003435Z","caller":"traceutil/trace.go:171","msg":"trace[243593102] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"121.913664ms","start":"2026-05-20T02:14:16.881484Z","end":"2026-05-20T02:14:17.003397Z","steps":["trace[243593102] 'process raft request' (duration: 121.659062ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:17.239408Z","caller":"traceutil/trace.go:171","msg":"trace[1891511649] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"174.201486ms","start":"2026-05-20T02:14:17.065182Z","end":"2026-05-20T02:14:17.239383Z","steps":["trace[1891511649] 'read index received' (duration: 148.801228ms)","trace[1891511649] 'applied index is now lower than readState.Index' (duration: 25.399218ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:17.239543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.347603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-20T02:14:17.239581Z","caller":"traceutil/trace.go:171","msg":"trace[984587881] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:326; }","duration":"174.434327ms","start":"2026-05-20T02:14:17.065132Z","end":"2026-05-20T02:14:17.239566Z","steps":["trace[984587881] 'agreement among raft nodes before linearized reading' (duration: 174.348913ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:17.239552Z","caller":"traceutil/trace.go:171","msg":"trace[91204594] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"203.480948ms","start":"2026-05-20T02:14:17.036027Z","end":"2026-05-20T02:14:17.239508Z","steps":["trace[91204594] 'process raft request' (duration: 178.046958ms)","trace[91204594] 'compare' (duration: 25.203999ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:19.86835Z","caller":"traceutil/trace.go:171","msg":"trace[1679653997] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:365; }","duration":"104.098732ms","start":"2026-05-20T02:14:19.764223Z","end":"2026-05-20T02:14:19.868321Z","steps":["trace[1679653997] 'read index received' (duration: 57.120145ms)","trace[1679653997] 'applied index is now lower than readState.Index' (duration: 46.977517ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:19.8685Z","caller":"traceutil/trace.go:171","msg":"trace[100775138] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"115.521709ms","start":"2026-05-20T02:14:19.752943Z","end":"2026-05-20T02:14:19.868465Z","steps":["trace[100775138] 'process raft request' (duration: 68.523741ms)","trace[100775138] 'compare' (duration: 46.6186ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:19.868585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.353944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-20T02:14:19.868746Z","caller":"traceutil/trace.go:171","msg":"trace[670242246] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:354; }","duration":"104.558113ms","start":"2026-05-20T02:14:19.764171Z","end":"2026-05-20T02:14:19.868729Z","steps":["trace[670242246] 'agreement among raft nodes before linearized reading' (duration: 104.303271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:20.45572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.088031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:20.455842Z","caller":"traceutil/trace.go:171","msg":"trace[692326463] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"150.056027ms","start":"2026-05-20T02:14:20.305764Z","end":"2026-05-20T02:14:20.45582Z","steps":["trace[692326463] 'process raft request' (duration: 20.556458ms)","trace[692326463] 'compare' (duration: 128.981055ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:20.468596Z","caller":"traceutil/trace.go:171","msg":"trace[967601704] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"158.954423ms","start":"2026-05-20T02:14:20.309626Z","end":"2026-05-20T02:14:20.468581Z","steps":["trace[967601704] 'process raft request' (duration: 158.854828ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.468772Z","caller":"traceutil/trace.go:171","msg":"trace[1417658698] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"158.67005ms","start":"2026-05-20T02:14:20.310093Z","end":"2026-05-20T02:14:20.468763Z","steps":["trace[1417658698] 'process raft request' (duration: 158.44946ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.468745Z","caller":"traceutil/trace.go:171","msg":"trace[1667793592] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:372; }","duration":"154.153164ms","start":"2026-05-20T02:14:20.314559Z","end":"2026-05-20T02:14:20.468712Z","steps":["trace[1667793592] 'read index received' (duration: 11.729455ms)","trace[1667793592] 'applied index is now lower than readState.Index' (duration: 142.422109ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:20.468896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.322661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-20T02:14:20.468972Z","caller":"traceutil/trace.go:171","msg":"trace[2115563356] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:363; }","duration":"154.424566ms","start":"2026-05-20T02:14:20.314529Z","end":"2026-05-20T02:14:20.468954Z","steps":["trace[2115563356] 'agreement among raft nodes before linearized reading' (duration: 154.311371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:20.468975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.506029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T02:14:20.469019Z","caller":"traceutil/trace.go:171","msg":"trace[2108596588] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:363; }","duration":"104.593952ms","start":"2026-05-20T02:14:20.364412Z","end":"2026-05-20T02:14:20.469006Z","steps":["trace[2108596588] 'agreement among raft nodes before linearized reading' (duration: 104.473617ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.633339Z","caller":"traceutil/trace.go:171","msg":"trace[1992661466] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"157.635133ms","start":"2026-05-20T02:14:20.475678Z","end":"2026-05-20T02:14:20.633313Z","steps":["trace[1992661466] 'process raft request' (duration: 155.540677ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.633474Z","caller":"traceutil/trace.go:171","msg":"trace[114441633] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"154.240968ms","start":"2026-05-20T02:14:20.479214Z","end":"2026-05-20T02:14:20.633455Z","steps":["trace[114441633] 'process raft request' (duration: 154.077501ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.633578Z","caller":"traceutil/trace.go:171","msg":"trace[1630232699] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"152.038007ms","start":"2026-05-20T02:14:20.481526Z","end":"2026-05-20T02:14:20.633564Z","steps":["trace[1630232699] 'process raft request' (duration: 151.804307ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.633589Z","caller":"traceutil/trace.go:171","msg":"trace[1915591422] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"148.936096ms","start":"2026-05-20T02:14:20.48462Z","end":"2026-05-20T02:14:20.633556Z","steps":["trace[1915591422] 'process raft request' (duration: 148.740737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:20.633881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.529304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-20T02:14:20.63396Z","caller":"traceutil/trace.go:171","msg":"trace[174458915] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:369; }","duration":"119.673351ms","start":"2026-05-20T02:14:20.51427Z","end":"2026-05-20T02:14:20.633943Z","steps":["trace[174458915] 'agreement among raft nodes before linearized reading' (duration: 119.518073ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.63341Z","caller":"traceutil/trace.go:171","msg":"trace[850030977] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:375; }","duration":"119.085504ms","start":"2026-05-20T02:14:20.514307Z","end":"2026-05-20T02:14:20.633393Z","steps":["trace[850030977] 'read index received' (duration: 21.972612ms)","trace[850030977] 'applied index is now lower than readState.Index' (duration: 97.112251ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:20.634381Z","caller":"traceutil/trace.go:171","msg":"trace[1412835697] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"155.865342ms","start":"2026-05-20T02:14:20.477512Z","end":"2026-05-20T02:14:20.633378Z","steps":["trace[1412835697] 'process raft request' (duration: 155.746246ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.896105Z","caller":"traceutil/trace.go:171","msg":"trace[1825820211] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"257.985481ms","start":"2026-05-20T02:14:20.638074Z","end":"2026-05-20T02:14:20.896059Z","steps":["trace[1825820211] 'process raft request' (duration: 218.066039ms)","trace[1825820211] 'compare' (duration: 39.757274ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:20.896616Z","caller":"traceutil/trace.go:171","msg":"trace[1280574890] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"255.753429ms","start":"2026-05-20T02:14:20.640847Z","end":"2026-05-20T02:14:20.8966Z","steps":["trace[1280574890] 'process raft request' (duration: 255.377272ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.896732Z","caller":"traceutil/trace.go:171","msg":"trace[1113894880] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"255.682656ms","start":"2026-05-20T02:14:20.640977Z","end":"2026-05-20T02:14:20.896659Z","steps":["trace[1113894880] 'process raft request' (duration: 255.55601ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.899435Z","caller":"traceutil/trace.go:171","msg":"trace[1244197760] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"258.109397ms","start":"2026-05-20T02:14:20.641025Z","end":"2026-05-20T02:14:20.899134Z","steps":["trace[1244197760] 'process raft request' (duration: 255.575501ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.899452Z","caller":"traceutil/trace.go:171","msg":"trace[1057062936] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"258.249312ms","start":"2026-05-20T02:14:20.641159Z","end":"2026-05-20T02:14:20.899408Z","steps":["trace[1057062936] 'process raft request' (duration: 257.665336ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.899466Z","caller":"traceutil/trace.go:171","msg":"trace[1892470333] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"258.346177ms","start":"2026-05-20T02:14:20.641086Z","end":"2026-05-20T02:14:20.899432Z","steps":["trace[1892470333] 'process raft request' (duration: 257.578892ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.902198Z","caller":"traceutil/trace.go:171","msg":"trace[406554744] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"260.010244ms","start":"2026-05-20T02:14:20.642141Z","end":"2026-05-20T02:14:20.902151Z","steps":["trace[406554744] 'process raft request' (duration: 256.893931ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:20.903508Z","caller":"traceutil/trace.go:171","msg":"trace[1384070585] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:381; }","duration":"238.649898ms","start":"2026-05-20T02:14:20.664812Z","end":"2026-05-20T02:14:20.903461Z","steps":["trace[1384070585] 'read index received' (duration: 11.817969ms)","trace[1384070585] 'applied index is now lower than readState.Index' (duration: 226.830859ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:20.905771Z","caller":"traceutil/trace.go:171","msg":"trace[81965588] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"261.213248ms","start":"2026-05-20T02:14:20.64308Z","end":"2026-05-20T02:14:20.904293Z","steps":["trace[81965588] 'process raft request' (duration: 257.913868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:20.905951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.118811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-20T02:14:20.906Z","caller":"traceutil/trace.go:171","msg":"trace[1191821400] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:378; }","duration":"241.210305ms","start":"2026-05-20T02:14:20.66478Z","end":"2026-05-20T02:14:20.90599Z","steps":["trace[1191821400] 'agreement among raft nodes before linearized reading' (duration: 238.779684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:21.224371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.096028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:21.224634Z","caller":"traceutil/trace.go:171","msg":"trace[38480860] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"318.421268ms","start":"2026-05-20T02:14:20.906166Z","end":"2026-05-20T02:14:21.224587Z","steps":["trace[38480860] 'process raft request' (duration: 175.037057ms)","trace[38480860] 'compare' (duration: 142.883689ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:21.224799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:20.906148Z","time spent":"318.573775ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:21.224927Z","caller":"traceutil/trace.go:171","msg":"trace[2057479512] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"313.385118ms","start":"2026-05-20T02:14:20.911516Z","end":"2026-05-20T02:14:21.224901Z","steps":["trace[2057479512] 'process raft request' (duration: 313.075904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:21.225032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:20.911497Z","time spent":"313.493493ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:21.225098Z","caller":"traceutil/trace.go:171","msg":"trace[1449332764] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"318.810526ms","start":"2026-05-20T02:14:20.906263Z","end":"2026-05-20T02:14:21.225073Z","steps":["trace[1449332764] 'process raft request' (duration: 318.283722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:21.225207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:20.906252Z","time spent":"318.895379ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:21.225268Z","caller":"traceutil/trace.go:171","msg":"trace[954959890] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:390; }","duration":"318.208928ms","start":"2026-05-20T02:14:20.906955Z","end":"2026-05-20T02:14:21.225164Z","steps":["trace[954959890] 'read index received' (duration: 39.398418ms)","trace[954959890] 'applied index is now lower than readState.Index' (duration: 278.80671ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:21.225377Z","caller":"traceutil/trace.go:171","msg":"trace[969841303] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"319.1341ms","start":"2026-05-20T02:14:20.906226Z","end":"2026-05-20T02:14:21.22536Z","steps":["trace[969841303] 'process raft request' (duration: 318.260141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:21.225487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:20.906212Z","time spent":"319.214014ms","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2886,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:14:21.225531Z","caller":"traceutil/trace.go:171","msg":"trace[1601888446] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"275.71749ms","start":"2026-05-20T02:14:20.949789Z","end":"2026-05-20T02:14:21.225506Z","steps":["trace[1601888446] 'process raft request' (duration: 274.869391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:21.225688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.720211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-05-20T02:14:21.225742Z","caller":"traceutil/trace.go:171","msg":"trace[844010305] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:384; }","duration":"318.798805ms","start":"2026-05-20T02:14:20.90693Z","end":"2026-05-20T02:14:21.225729Z","steps":["trace[844010305] 'agreement among raft nodes before linearized reading' (duration: 318.416537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:21.225775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:20.906922Z","time spent":"318.845887ms","remote":"127.0.0.1:34844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":3730,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-05-20T02:14:21.463109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.293377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:21.463439Z","caller":"traceutil/trace.go:171","msg":"trace[607978376] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"231.016256ms","start":"2026-05-20T02:14:21.232389Z","end":"2026-05-20T02:14:21.463405Z","steps":["trace[607978376] 'process raft request' (duration: 120.355472ms)","trace[607978376] 'compare' (duration: 110.089979ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:21.463648Z","caller":"traceutil/trace.go:171","msg":"trace[2042445213] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"229.354311ms","start":"2026-05-20T02:14:21.234274Z","end":"2026-05-20T02:14:21.463629Z","steps":["trace[2042445213] 'process raft request' (duration: 228.970254ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:21.463889Z","caller":"traceutil/trace.go:171","msg":"trace[1294324375] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"228.692912ms","start":"2026-05-20T02:14:21.23516Z","end":"2026-05-20T02:14:21.463853Z","steps":["trace[1294324375] 'process raft request' (duration: 228.402998ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:21.675658Z","caller":"traceutil/trace.go:171","msg":"trace[270765268] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"207.389389ms","start":"2026-05-20T02:14:21.46824Z","end":"2026-05-20T02:14:21.675629Z","steps":["trace[270765268] 'process raft request' (duration: 171.669897ms)","trace[270765268] 'compare' (duration: 35.457531ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:21.675585Z","caller":"traceutil/trace.go:171","msg":"trace[1961737228] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"207.298125ms","start":"2026-05-20T02:14:21.468259Z","end":"2026-05-20T02:14:21.675557Z","steps":["trace[1961737228] 'process raft request' (duration: 207.242293ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:21.677758Z","caller":"traceutil/trace.go:171","msg":"trace[1902022314] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"207.763807ms","start":"2026-05-20T02:14:21.469974Z","end":"2026-05-20T02:14:21.677738Z","steps":["trace[1902022314] 'process raft request' (duration: 207.638341ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:24.692263Z","caller":"traceutil/trace.go:171","msg":"trace[427006339] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"103.132166ms","start":"2026-05-20T02:14:24.589108Z","end":"2026-05-20T02:14:24.69224Z","steps":["trace[427006339] 'process raft request' (duration: 102.976169ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:26.263813Z","caller":"traceutil/trace.go:171","msg":"trace[403013377] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:429; }","duration":"410.474769ms","start":"2026-05-20T02:14:25.853308Z","end":"2026-05-20T02:14:26.263783Z","steps":["trace[403013377] 'read index received' (duration: 410.216668ms)","trace[403013377] 'applied index is now lower than readState.Index' (duration: 256.271µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:26.263946Z","caller":"traceutil/trace.go:171","msg":"trace[1924234432] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"505.645332ms","start":"2026-05-20T02:14:25.75829Z","end":"2026-05-20T02:14:26.263935Z","steps":["trace[1924234432] 'process raft request' (duration: 505.277866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:26.264051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:25.758265Z","time spent":"505.710086ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:14:26.264059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.740111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4261"} {"level":"info","ts":"2026-05-20T02:14:26.264147Z","caller":"traceutil/trace.go:171","msg":"trace[1209456780] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:416; }","duration":"410.874716ms","start":"2026-05-20T02:14:25.853254Z","end":"2026-05-20T02:14:26.264129Z","steps":["trace[1209456780] 'agreement among raft nodes before linearized reading' (duration: 410.73808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:26.264194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:25.853207Z","time spent":"410.97734ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4285,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-05-20T02:14:26.296564Z","caller":"traceutil/trace.go:171","msg":"trace[1093865683] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"214.761723ms","start":"2026-05-20T02:14:26.081779Z","end":"2026-05-20T02:14:26.29654Z","steps":["trace[1093865683] 'process raft request' (duration: 214.589586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:26.296713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.261734ms","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-05-20T02:14:26.296795Z","caller":"traceutil/trace.go:171","msg":"trace[1218456814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"157.39495ms","start":"2026-05-20T02:14:26.139384Z","end":"2026-05-20T02:14:26.296779Z","steps":["trace[1218456814] 'agreement among raft nodes before linearized reading' (duration: 157.268555ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:26.296745Z","caller":"traceutil/trace.go:171","msg":"trace[917768452] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"178.801095ms","start":"2026-05-20T02:14:26.117927Z","end":"2026-05-20T02:14:26.296728Z","steps":["trace[917768452] 'process raft request' (duration: 178.569495ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:26.442313Z","caller":"traceutil/trace.go:171","msg":"trace[1928597960] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:432; }","duration":"145.674129ms","start":"2026-05-20T02:14:26.296614Z","end":"2026-05-20T02:14:26.442288Z","steps":["trace[1928597960] 'read index received' (duration: 144.120173ms)","trace[1928597960] 'applied index is now lower than readState.Index' (duration: 1.553076ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:26.442395Z","caller":"traceutil/trace.go:171","msg":"trace[832080164] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"169.919015ms","start":"2026-05-20T02:14:26.27244Z","end":"2026-05-20T02:14:26.442359Z","steps":["trace[832080164] 'process raft request' (duration: 168.145799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:26.442443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.483135ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:26.442631Z","caller":"traceutil/trace.go:171","msg":"trace[1395426768] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:419; }","duration":"150.679633ms","start":"2026-05-20T02:14:26.291934Z","end":"2026-05-20T02:14:26.442614Z","steps":["trace[1395426768] 'agreement among raft nodes before linearized reading' (duration: 150.448873ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:26.442834Z","caller":"traceutil/trace.go:171","msg":"trace[2081838728] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"141.976341ms","start":"2026-05-20T02:14:26.300824Z","end":"2026-05-20T02:14:26.4428Z","steps":["trace[2081838728] 'process raft request' (duration: 141.800083ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:36.617116Z","caller":"traceutil/trace.go:171","msg":"trace[783215376] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"270.619881ms","start":"2026-05-20T02:14:36.346471Z","end":"2026-05-20T02:14:36.617091Z","steps":["trace[783215376] 'read index received' (duration: 270.486266ms)","trace[783215376] 'applied index is now lower than readState.Index' (duration: 132.505µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:36.617349Z","caller":"traceutil/trace.go:171","msg":"trace[75062990] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"293.859237ms","start":"2026-05-20T02:14:36.323391Z","end":"2026-05-20T02:14:36.61725Z","steps":["trace[75062990] 'process raft request' (duration: 293.538685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:36.617501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.000985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T02:14:36.617586Z","caller":"traceutil/trace.go:171","msg":"trace[1869670891] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:477; }","duration":"271.142201ms","start":"2026-05-20T02:14:36.346422Z","end":"2026-05-20T02:14:36.617564Z","steps":["trace[1869670891] 'agreement among raft nodes before linearized reading' (duration: 270.84891ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:36.724649Z","caller":"traceutil/trace.go:171","msg":"trace[386777758] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:493; }","duration":"107.324626ms","start":"2026-05-20T02:14:36.617284Z","end":"2026-05-20T02:14:36.724609Z","steps":["trace[386777758] 'read index received' (duration: 106.175482ms)","trace[386777758] 'applied index is now lower than readState.Index' (duration: 1.147904ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:36.724658Z","caller":"traceutil/trace.go:171","msg":"trace[499219232] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"190.794323ms","start":"2026-05-20T02:14:36.533833Z","end":"2026-05-20T02:14:36.724628Z","steps":["trace[499219232] 'process raft request' (duration: 189.604417ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:36.724773Z","caller":"traceutil/trace.go:171","msg":"trace[1047215064] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"103.633954ms","start":"2026-05-20T02:14:36.621128Z","end":"2026-05-20T02:14:36.724762Z","steps":["trace[1047215064] 'process raft request' (duration: 103.430186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:36.724974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.760544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:14:36.725065Z","caller":"traceutil/trace.go:171","msg":"trace[113087196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"175.897649ms","start":"2026-05-20T02:14:36.549145Z","end":"2026-05-20T02:14:36.725043Z","steps":["trace[113087196] 'agreement among raft nodes before linearized reading' (duration: 175.578777ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:42.936373Z","caller":"traceutil/trace.go:171","msg":"trace[2063476613] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"179.29828ms","start":"2026-05-20T02:14:42.757056Z","end":"2026-05-20T02:14:42.936354Z","steps":["trace[2063476613] 'read index received' (duration: 179.166215ms)","trace[2063476613] 'applied index is now lower than readState.Index' (duration: 131.105µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:42.936449Z","caller":"traceutil/trace.go:171","msg":"trace[1733483516] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"189.092685ms","start":"2026-05-20T02:14:42.747324Z","end":"2026-05-20T02:14:42.936417Z","steps":["trace[1733483516] 'process raft request' (duration: 188.915649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:42.936559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.480276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:14:42.936737Z","caller":"traceutil/trace.go:171","msg":"trace[912852965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:491; }","duration":"179.702604ms","start":"2026-05-20T02:14:42.757021Z","end":"2026-05-20T02:14:42.936724Z","steps":["trace[912852965] 'agreement among raft nodes before linearized reading' (duration: 179.480206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:42.937057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.720963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-05-20T02:14:42.937159Z","caller":"traceutil/trace.go:171","msg":"trace[1497654306] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:491; }","duration":"174.847928ms","start":"2026-05-20T02:14:42.762298Z","end":"2026-05-20T02:14:42.937146Z","steps":["trace[1497654306] 'agreement among raft nodes before linearized reading' (duration: 174.63493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:42.937199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.084508ms","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-05-20T02:14:42.937288Z","caller":"traceutil/trace.go:171","msg":"trace[1331177474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:491; }","duration":"126.219092ms","start":"2026-05-20T02:14:42.811054Z","end":"2026-05-20T02:14:42.937273Z","steps":["trace[1331177474] 'agreement among raft nodes before linearized reading' (duration: 126.062307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.622566Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.088840214s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T02:14:46.622895Z","caller":"traceutil/trace.go:171","msg":"trace[293971337] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.089257068s","start":"2026-05-20T02:14:45.533614Z","end":"2026-05-20T02:14:46.622871Z","steps":["trace[293971337] 'process raft request' (duration: 1.089122893s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.533593Z","time spent":"1.089345551s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:46.633007Z","caller":"traceutil/trace.go:171","msg":"trace[766421978] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.096110026s","start":"2026-05-20T02:14:45.536855Z","end":"2026-05-20T02:14:46.632965Z","steps":["trace[766421978] 'process raft request' (duration: 1.095868938s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:46.633066Z","caller":"traceutil/trace.go:171","msg":"trace[2134726227] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.089060788s","start":"2026-05-20T02:14:45.543977Z","end":"2026-05-20T02:14:46.633037Z","steps":["trace[2134726227] 'process raft request' (duration: 1.088914353s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:46.633124Z","caller":"traceutil/trace.go:171","msg":"trace[1185171482] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.083509642s","start":"2026-05-20T02:14:45.549583Z","end":"2026-05-20T02:14:46.633092Z","steps":["trace[1185171482] 'process raft request' (duration: 1.083350326s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.633198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.54397Z","time spent":"1.089163911s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:46.633173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.536834Z","time spent":"1.096262912s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:46.633215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.549536Z","time spent":"1.083633175s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:46.633359Z","caller":"traceutil/trace.go:171","msg":"trace[939344942] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.067921901s","start":"2026-05-20T02:14:45.565423Z","end":"2026-05-20T02:14:46.633345Z","steps":["trace[939344942] 'process raft request' (duration: 1.067701804s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:46.633403Z","caller":"traceutil/trace.go:171","msg":"trace[104808056] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.059908829s","start":"2026-05-20T02:14:45.573479Z","end":"2026-05-20T02:14:46.633387Z","steps":["trace[104808056] 'process raft request' (duration: 1.059781334s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:46.633375Z","caller":"traceutil/trace.go:171","msg":"trace[1647066287] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.075922494s","start":"2026-05-20T02:14:45.557425Z","end":"2026-05-20T02:14:46.633348Z","steps":["trace[1647066287] 'process raft request' (duration: 1.075622533s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.633451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.573471Z","time spent":"1.05995766s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:46.633467Z","caller":"traceutil/trace.go:171","msg":"trace[1923727463] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.055995641s","start":"2026-05-20T02:14:45.57746Z","end":"2026-05-20T02:14:46.633456Z","steps":["trace[1923727463] 'process raft request' (duration: 1.055878587s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.63351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.557418Z","time spent":"1.076027667s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:46.633443Z","caller":"traceutil/trace.go:171","msg":"trace[573587014] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.081992737s","start":"2026-05-20T02:14:45.55132Z","end":"2026-05-20T02:14:46.633313Z","steps":["trace[573587014] 'process raft request' (duration: 1.081690027s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.633409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.565414Z","time spent":"1.067969104s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:46.633577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.577452Z","time spent":"1.056062783s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:46.633652Z","caller":"traceutil/trace.go:171","msg":"trace[110275897] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.025168144s","start":"2026-05-20T02:14:45.608475Z","end":"2026-05-20T02:14:46.633643Z","steps":["trace[110275897] 'process raft request' (duration: 1.024928715s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:46.633618Z","caller":"traceutil/trace.go:171","msg":"trace[1217633268] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:552; }","duration":"420.602302ms","start":"2026-05-20T02:14:46.212995Z","end":"2026-05-20T02:14:46.633597Z","steps":["trace[1217633268] 'read index received' (duration: 410.085985ms)","trace[1217633268] 'applied index is now lower than readState.Index' (duration: 10.515127ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:46.633668Z","caller":"traceutil/trace.go:171","msg":"trace[1390900362] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.092041893s","start":"2026-05-20T02:14:45.540943Z","end":"2026-05-20T02:14:46.632984Z","steps":["trace[1390900362] 'process raft request' (duration: 1.091905008s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.633688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.608444Z","time spent":"1.025226816s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:46.633687Z","caller":"traceutil/trace.go:171","msg":"trace[1815390287] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"923.032592ms","start":"2026-05-20T02:14:45.710643Z","end":"2026-05-20T02:14:46.633675Z","steps":["trace[1815390287] 'process raft request' (duration: 922.882917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.633711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.551311Z","time spent":"1.082276688s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:46.633739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.710608Z","time spent":"923.107694ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:46.633821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.755658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:46.633857Z","caller":"traceutil/trace.go:171","msg":"trace[478167819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"420.928634ms","start":"2026-05-20T02:14:46.212918Z","end":"2026-05-20T02:14:46.633846Z","steps":["trace[478167819] 'agreement among raft nodes before linearized reading' (duration: 420.767308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:46.633886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:46.21289Z","time spent":"420.989466ms","remote":"127.0.0.1:34378","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-05-20T02:14:46.633877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:45.540936Z","time spent":"1.092904963s","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:47.073798Z","caller":"traceutil/trace.go:171","msg":"trace[1492487492] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"259.4498ms","start":"2026-05-20T02:14:46.814316Z","end":"2026-05-20T02:14:47.073766Z","steps":["trace[1492487492] 'process raft request' (duration: 169.656987ms)","trace[1492487492] 'compare' (duration: 89.554055ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:47.075805Z","caller":"traceutil/trace.go:171","msg":"trace[1449268554] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"191.153433ms","start":"2026-05-20T02:14:46.884632Z","end":"2026-05-20T02:14:47.075786Z","steps":["trace[1449268554] 'process raft request' (duration: 190.691197ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:47.075939Z","caller":"traceutil/trace.go:171","msg":"trace[1583887836] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"191.167224ms","start":"2026-05-20T02:14:46.884766Z","end":"2026-05-20T02:14:47.075934Z","steps":["trace[1583887836] 'process raft request' (duration: 190.694188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:52.723677Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899356835752548,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T02:14:52.994862Z","caller":"traceutil/trace.go:171","msg":"trace[179934868] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"781.920414ms","start":"2026-05-20T02:14:52.21291Z","end":"2026-05-20T02:14:52.99483Z","steps":["trace[179934868] 'read index received' (duration: 779.002347ms)","trace[179934868] 'applied index is now lower than readState.Index' (duration: 2.916897ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:52.994987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.054678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:52.995019Z","caller":"traceutil/trace.go:171","msg":"trace[1649896277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"782.129131ms","start":"2026-05-20T02:14:52.21288Z","end":"2026-05-20T02:14:52.995009Z","steps":["trace[1649896277] 'agreement among raft nodes before linearized reading' (duration: 782.052778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:52.995055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:52.212865Z","time spent":"782.182572ms","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T02:14:52.99508Z","caller":"traceutil/trace.go:171","msg":"trace[846530785] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"838.939356ms","start":"2026-05-20T02:14:52.156113Z","end":"2026-05-20T02:14:52.995053Z","steps":["trace[846530785] 'process raft request' (duration: 836.867548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:52.995226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:52.156091Z","time spent":"839.06192ms","remote":"127.0.0.1:34480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036221,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:14:53.500805Z","caller":"traceutil/trace.go:171","msg":"trace[1700347510] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"416.078175ms","start":"2026-05-20T02:14:53.084705Z","end":"2026-05-20T02:14:53.500783Z","steps":["trace[1700347510] 'process raft request' (duration: 411.186175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:53.500979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:53.084677Z","time spent":"416.21619ms","remote":"127.0.0.1:34762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:53.500543Z","caller":"traceutil/trace.go:171","msg":"trace[1995004643] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"377.802583ms","start":"2026-05-20T02:14:53.122662Z","end":"2026-05-20T02:14:53.500464Z","steps":["trace[1995004643] 'read index received' (duration: 373.170091ms)","trace[1995004643] 'applied index is now lower than readState.Index' (duration: 4.630422ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:53.501279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.551487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-20T02:14:53.501377Z","caller":"traceutil/trace.go:171","msg":"trace[208900223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"378.747514ms","start":"2026-05-20T02:14:53.122608Z","end":"2026-05-20T02:14:53.501356Z","steps":["trace[208900223] 'agreement among raft nodes before linearized reading' (duration: 378.33571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:53.501474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:53.122583Z","time spent":"378.876197ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T02:14:53.501541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.83151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-20T02:14:53.501603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.182045ms","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-05-20T02:14:53.501677Z","caller":"traceutil/trace.go:171","msg":"trace[400771032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"378.297309ms","start":"2026-05-20T02:14:53.123365Z","end":"2026-05-20T02:14:53.501662Z","steps":["trace[400771032] 'agreement among raft nodes before linearized reading' (duration: 378.02044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:53.501747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:53.123346Z","time spent":"378.390872ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T02:14:53.50167Z","caller":"traceutil/trace.go:171","msg":"trace[95257344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"280.998405ms","start":"2026-05-20T02:14:53.220644Z","end":"2026-05-20T02:14:53.501642Z","steps":["trace[95257344] 'agreement among raft nodes before linearized reading' (duration: 280.761408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:53.501881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.880168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T02:14:53.501949Z","caller":"traceutil/trace.go:171","msg":"trace[1092188263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"374.971651ms","start":"2026-05-20T02:14:53.126954Z","end":"2026-05-20T02:14:53.501926Z","steps":["trace[1092188263] 'agreement among raft nodes before linearized reading' (duration: 374.766224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:53.50201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:53.126938Z","time spent":"375.057353ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T02:14:53.502101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.9612ms","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-05-20T02:14:53.502354Z","caller":"traceutil/trace.go:171","msg":"trace[70259032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"375.323412ms","start":"2026-05-20T02:14:53.127Z","end":"2026-05-20T02:14:53.502324Z","steps":["trace[70259032] 'agreement among raft nodes before linearized reading' (duration: 374.556036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:53.502479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:53.126997Z","time spent":"375.463316ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T02:14:54.714198Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899356835752573,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-20T02:14:54.949328Z","caller":"traceutil/trace.go:171","msg":"trace[943316428] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"926.488615ms","start":"2026-05-20T02:14:54.022806Z","end":"2026-05-20T02:14:54.949295Z","steps":["trace[943316428] 'process raft request' (duration: 926.271388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:54.949522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:54.022788Z","time spent":"926.640871ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:14:55.11354Z","caller":"traceutil/trace.go:171","msg":"trace[1159771574] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"900.023736ms","start":"2026-05-20T02:14:54.21349Z","end":"2026-05-20T02:14:55.113514Z","steps":["trace[1159771574] 'read index received' (duration: 735.530594ms)","trace[1159771574] 'applied index is now lower than readState.Index' (duration: 164.491762ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:55.113685Z","caller":"traceutil/trace.go:171","msg":"trace[933247169] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.052222702s","start":"2026-05-20T02:14:54.061432Z","end":"2026-05-20T02:14:55.113654Z","steps":["trace[933247169] 'process raft request' (duration: 1.021018229s)","trace[933247169] 'compare' (duration: 30.939524ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:55.113709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.206242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:55.113749Z","caller":"traceutil/trace.go:171","msg":"trace[1770295582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"900.291605ms","start":"2026-05-20T02:14:54.213446Z","end":"2026-05-20T02:14:55.113737Z","steps":["trace[1770295582] 'agreement among raft nodes before linearized reading' (duration: 900.184321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:55.113781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:54.213428Z","time spent":"900.346537ms","remote":"127.0.0.1:34376","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-05-20T02:14:55.113783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:54.061377Z","time spent":"1.052353256s","remote":"127.0.0.1:34764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:57.026362Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.487211638s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-20T02:14:57.039544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.826091651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:57.039619Z","caller":"traceutil/trace.go:171","msg":"trace[386473143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.826221325s","start":"2026-05-20T02:14:55.213377Z","end":"2026-05-20T02:14:57.039598Z","steps":["trace[386473143] 'range keys from in-memory index tree' (duration: 1.825994998s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:57.039658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:55.213351Z","time spent":"1.826298248s","remote":"127.0.0.1:34378","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-05-20T02:14:57.040032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.523430584s","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-05-20T02:14:57.040094Z","caller":"traceutil/trace.go:171","msg":"trace[735195718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"1.523521497s","start":"2026-05-20T02:14:55.516556Z","end":"2026-05-20T02:14:57.040077Z","steps":["trace[735195718] 'range keys from in-memory index tree' (duration: 1.523233958s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:57.040142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:55.516534Z","time spent":"1.523596039s","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-20T02:14:57.040341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520123667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-20T02:14:57.040409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.519944081s","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-05-20T02:14:57.040508Z","caller":"traceutil/trace.go:171","msg":"trace[434620744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"1.520062175s","start":"2026-05-20T02:14:55.520423Z","end":"2026-05-20T02:14:57.040486Z","steps":["trace[434620744] 'range keys from in-memory index tree' (duration: 1.519673723s)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:57.040428Z","caller":"traceutil/trace.go:171","msg":"trace[268651610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"1.52023658s","start":"2026-05-20T02:14:55.520169Z","end":"2026-05-20T02:14:57.040406Z","steps":["trace[268651610] 'range keys from in-memory index tree' (duration: 1.519964742s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:57.040606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:55.520158Z","time spent":"1.520436167s","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T02:14:57.040564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:55.520332Z","time spent":"1.52022191s","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-20T02:14:57.040985Z","caller":"traceutil/trace.go:171","msg":"trace[1985854658] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.508826773s","start":"2026-05-20T02:14:55.532123Z","end":"2026-05-20T02:14:57.04095Z","steps":["trace[1985854658] 'process raft request' (duration: 1.494744759s)","trace[1985854658] 'compare' (duration: 12.884117ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:57.041104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.202074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:57.041103Z","caller":"traceutil/trace.go:171","msg":"trace[95070892] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"122.048178ms","start":"2026-05-20T02:14:56.918943Z","end":"2026-05-20T02:14:57.040991Z","steps":["trace[95070892] 'process raft request' (duration: 121.960575ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:57.041144Z","caller":"traceutil/trace.go:171","msg":"trace[1045164786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"485.280157ms","start":"2026-05-20T02:14:56.555856Z","end":"2026-05-20T02:14:57.041136Z","steps":["trace[1045164786] 'agreement among raft nodes before linearized reading' (duration: 485.191135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:57.041147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:55.532096Z","time spent":"1.508962338s","remote":"127.0.0.1:34480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:14:57.04118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:56.555834Z","time spent":"485.339728ms","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T02:14:57.04102Z","caller":"traceutil/trace.go:171","msg":"trace[1708897881] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"485.099081ms","start":"2026-05-20T02:14:56.555905Z","end":"2026-05-20T02:14:57.041004Z","steps":["trace[1708897881] 'read index received' (duration: 470.752028ms)","trace[1708897881] 'applied index is now lower than readState.Index' (duration: 14.343603ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:57.044888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520016694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T02:14:57.044946Z","caller":"traceutil/trace.go:171","msg":"trace[1395357716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"1.524779744s","start":"2026-05-20T02:14:55.520153Z","end":"2026-05-20T02:14:57.044933Z","steps":["trace[1395357716] 'range keys from in-memory index tree' (duration: 1.519822108s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:57.044975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:55.520135Z","time spent":"1.524828445s","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-20T02:14:57.453191Z","caller":"traceutil/trace.go:171","msg":"trace[6515881] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"126.605977ms","start":"2026-05-20T02:14:57.326566Z","end":"2026-05-20T02:14:57.453172Z","steps":["trace[6515881] 'process raft request' (duration: 126.474723ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:57.882524Z","caller":"traceutil/trace.go:171","msg":"trace[151660435] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"152.556806ms","start":"2026-05-20T02:14:57.729933Z","end":"2026-05-20T02:14:57.88249Z","steps":["trace[151660435] 'process raft request' (duration: 90.626971ms)","trace[151660435] 'compare' (duration: 61.77672ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:58.040071Z","caller":"traceutil/trace.go:171","msg":"trace[1863693845] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"152.487354ms","start":"2026-05-20T02:14:57.887565Z","end":"2026-05-20T02:14:58.040052Z","steps":["trace[1863693845] 'process raft request' (duration: 149.176341ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:58.040236Z","caller":"traceutil/trace.go:171","msg":"trace[1542793134] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"150.860903ms","start":"2026-05-20T02:14:57.889348Z","end":"2026-05-20T02:14:58.040209Z","steps":["trace[1542793134] 'process raft request' (duration: 150.42292ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:58.040402Z","caller":"traceutil/trace.go:171","msg":"trace[1215781987] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"151.594456ms","start":"2026-05-20T02:14:57.888798Z","end":"2026-05-20T02:14:58.040393Z","steps":["trace[1215781987] 'process raft request' (duration: 150.933735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:58.591375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.949404ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:14:58.591511Z","caller":"traceutil/trace.go:171","msg":"trace[2098749467] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:664; }","duration":"236.095938ms","start":"2026-05-20T02:14:58.355398Z","end":"2026-05-20T02:14:58.591494Z","steps":["trace[2098749467] 'range keys from in-memory index tree' (duration: 235.921373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.327322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.567159ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-20T02:14:59.327627Z","caller":"traceutil/trace.go:171","msg":"trace[1294451013] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"313.0241ms","start":"2026-05-20T02:14:59.01458Z","end":"2026-05-20T02:14:59.327604Z","steps":["trace[1294451013] 'process raft request' (duration: 312.869765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.327749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.014564Z","time spent":"313.114833ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17505,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:14:59.375894Z","caller":"traceutil/trace.go:171","msg":"trace[2123363785] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:696; }","duration":"322.786663ms","start":"2026-05-20T02:14:59.053081Z","end":"2026-05-20T02:14:59.375868Z","steps":["trace[2123363785] 'read index received' (duration: 71.466537ms)","trace[2123363785] 'applied index is now lower than readState.Index' (duration: 251.318666ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:59.375955Z","caller":"traceutil/trace.go:171","msg":"trace[1835201451] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"351.546625ms","start":"2026-05-20T02:14:59.024387Z","end":"2026-05-20T02:14:59.375933Z","steps":["trace[1835201451] 'process raft request' (duration: 351.349409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.376061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.024327Z","time spent":"351.679079ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:59.376334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.243727ms","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-05-20T02:14:59.376527Z","caller":"traceutil/trace.go:171","msg":"trace[1558365508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"323.353511ms","start":"2026-05-20T02:14:59.053032Z","end":"2026-05-20T02:14:59.376385Z","steps":["trace[1558365508] 'agreement among raft nodes before linearized reading' (duration: 322.986359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.376844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.053012Z","time spent":"323.69103ms","remote":"127.0.0.1:34698","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-05-20T02:14:59.634799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.713003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-20T02:14:59.63489Z","caller":"traceutil/trace.go:171","msg":"trace[1711787607] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"258.88366ms","start":"2026-05-20T02:14:59.375991Z","end":"2026-05-20T02:14:59.634875Z","steps":["trace[1711787607] 'read index received' (duration: 149.053154ms)","trace[1711787607] 'applied index is now lower than readState.Index' (duration: 109.829516ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:59.634997Z","caller":"traceutil/trace.go:171","msg":"trace[1545851623] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"410.40998ms","start":"2026-05-20T02:14:59.224553Z","end":"2026-05-20T02:14:59.634963Z","steps":["trace[1545851623] 'process raft request' (duration: 300.47465ms)","trace[1545851623] 'compare' (duration: 109.59885ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:14:59.635097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.724258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-bhzs6\" ","response":"range_response_count:1 size:4679"} {"level":"warn","ts":"2026-05-20T02:14:59.635095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.218232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-20T02:14:59.635155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.224525Z","time spent":"410.568495ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:59.635174Z","caller":"traceutil/trace.go:171","msg":"trace[474271873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"574.320124ms","start":"2026-05-20T02:14:59.060838Z","end":"2026-05-20T02:14:59.635158Z","steps":["trace[474271873] 'agreement among raft nodes before linearized reading' (duration: 574.156339ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:59.635172Z","caller":"traceutil/trace.go:171","msg":"trace[2071859120] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-bhzs6; range_end:; response_count:1; response_revision:677; }","duration":"301.847852ms","start":"2026-05-20T02:14:59.333307Z","end":"2026-05-20T02:14:59.635155Z","steps":["trace[2071859120] 'agreement among raft nodes before linearized reading' (duration: 301.587524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.635228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.060827Z","time spent":"574.383337ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T02:14:59.635263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.583813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-20T02:14:59.635041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.14781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T02:14:59.635344Z","caller":"traceutil/trace.go:171","msg":"trace[1171949448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"574.693936ms","start":"2026-05-20T02:14:59.060632Z","end":"2026-05-20T02:14:59.635326Z","steps":["trace[1171949448] 'agreement among raft nodes before linearized reading' (duration: 574.404037ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:59.635382Z","caller":"traceutil/trace.go:171","msg":"trace[1145675276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:677; }","duration":"575.535163ms","start":"2026-05-20T02:14:59.059829Z","end":"2026-05-20T02:14:59.635364Z","steps":["trace[1145675276] 'agreement among raft nodes before linearized reading' (duration: 575.082529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.635391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.060605Z","time spent":"574.777629ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-20T02:14:59.635434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.059815Z","time spent":"575.606444ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T02:14:59.635242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.33329Z","time spent":"301.938925ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4703,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-bhzs6\" "} {"level":"info","ts":"2026-05-20T02:14:59.773469Z","caller":"traceutil/trace.go:171","msg":"trace[2016484170] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"393.676481ms","start":"2026-05-20T02:14:59.379733Z","end":"2026-05-20T02:14:59.773409Z","steps":["trace[2016484170] 'process raft request' (duration: 375.937691ms)","trace[2016484170] 'compare' (duration: 17.424481ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:14:59.773781Z","caller":"traceutil/trace.go:171","msg":"trace[719274809] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"391.983058ms","start":"2026-05-20T02:14:59.381771Z","end":"2026-05-20T02:14:59.773754Z","steps":["trace[719274809] 'process raft request' (duration: 391.587516ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:14:59.773514Z","caller":"traceutil/trace.go:171","msg":"trace[1588691567] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"347.661524ms","start":"2026-05-20T02:14:59.425822Z","end":"2026-05-20T02:14:59.773484Z","steps":["trace[1588691567] 'process raft request' (duration: 347.605162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.774043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.37971Z","time spent":"394.077353ms","remote":"127.0.0.1:34916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:14:59.774047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.4258Z","time spent":"348.177839ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:14:59.773594Z","caller":"traceutil/trace.go:171","msg":"trace[1479722230] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"392.557646ms","start":"2026-05-20T02:14:59.381006Z","end":"2026-05-20T02:14:59.773564Z","steps":["trace[1479722230] 'process raft request' (duration: 392.267717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:14:59.77446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.380986Z","time spent":"393.391552ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:14:59.773999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.381293Z","time spent":"392.551576ms","remote":"127.0.0.1:34698","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-05-20T02:15:00.050321Z","caller":"traceutil/trace.go:171","msg":"trace[278877232] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"409.460929ms","start":"2026-05-20T02:14:59.640837Z","end":"2026-05-20T02:15:00.050298Z","steps":["trace[278877232] 'process raft request' (duration: 409.362376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:00.050463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.640819Z","time spent":"409.571552ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:15:00.050574Z","caller":"traceutil/trace.go:171","msg":"trace[600567955] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"404.791564ms","start":"2026-05-20T02:14:59.645764Z","end":"2026-05-20T02:15:00.050555Z","steps":["trace[600567955] 'process raft request' (duration: 404.727592ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.050602Z","caller":"traceutil/trace.go:171","msg":"trace[1100062214] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"409.707457ms","start":"2026-05-20T02:14:59.640839Z","end":"2026-05-20T02:15:00.050547Z","steps":["trace[1100062214] 'process raft request' (duration: 409.424608ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:00.050703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.645744Z","time spent":"404.883337ms","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4675,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:15:00.050613Z","caller":"traceutil/trace.go:171","msg":"trace[1299707990] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"409.676115ms","start":"2026-05-20T02:14:59.640919Z","end":"2026-05-20T02:15:00.050596Z","steps":["trace[1299707990] 'process raft request' (duration: 409.487849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:00.050895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.64081Z","time spent":"409.931564ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:15:00.051303Z","caller":"traceutil/trace.go:171","msg":"trace[346086137] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"424.515176ms","start":"2026-05-20T02:14:59.625755Z","end":"2026-05-20T02:15:00.05027Z","steps":["trace[346086137] 'process raft request' (duration: 364.784316ms)","trace[346086137] 'compare' (duration: 59.473012ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:15:00.051776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.62572Z","time spent":"425.705553ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-20T02:15:00.051398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:14:59.64089Z","time spent":"410.052257ms","remote":"127.0.0.1:34698","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-05-20T02:15:00.072452Z","caller":"traceutil/trace.go:171","msg":"trace[1747776938] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"292.079942ms","start":"2026-05-20T02:14:59.780338Z","end":"2026-05-20T02:15:00.072418Z","steps":["trace[1747776938] 'process raft request' (duration: 291.828954ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.072654Z","caller":"traceutil/trace.go:171","msg":"trace[355024262] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"291.351629ms","start":"2026-05-20T02:14:59.781278Z","end":"2026-05-20T02:15:00.07263Z","steps":["trace[355024262] 'process raft request' (duration: 291.03508ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.07313Z","caller":"traceutil/trace.go:171","msg":"trace[1189669174] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"248.703155ms","start":"2026-05-20T02:14:59.824416Z","end":"2026-05-20T02:15:00.073119Z","steps":["trace[1189669174] 'process raft request' (duration: 248.677545ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.073289Z","caller":"traceutil/trace.go:171","msg":"trace[2142902078] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"291.485923ms","start":"2026-05-20T02:14:59.781791Z","end":"2026-05-20T02:15:00.073277Z","steps":["trace[2142902078] 'process raft request' (duration: 290.698409ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.429759Z","caller":"traceutil/trace.go:171","msg":"trace[1282402605] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"370.584384ms","start":"2026-05-20T02:15:00.059152Z","end":"2026-05-20T02:15:00.429736Z","steps":["trace[1282402605] 'process raft request' (duration: 370.512442ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.429778Z","caller":"traceutil/trace.go:171","msg":"trace[1041371746] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"405.172208ms","start":"2026-05-20T02:15:00.024574Z","end":"2026-05-20T02:15:00.429746Z","steps":["trace[1041371746] 'process raft request' (duration: 404.964251ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:00.429905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:00.05913Z","time spent":"370.699447ms","remote":"127.0.0.1:34872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4387,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:15:00.430054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:00.024548Z","time spent":"405.287641ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:15:00.437286Z","caller":"traceutil/trace.go:171","msg":"trace[863311238] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"361.412452ms","start":"2026-05-20T02:15:00.075843Z","end":"2026-05-20T02:15:00.437256Z","steps":["trace[863311238] 'process raft request' (duration: 361.202856ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.437386Z","caller":"traceutil/trace.go:171","msg":"trace[2017375706] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"357.545694ms","start":"2026-05-20T02:15:00.079817Z","end":"2026-05-20T02:15:00.437363Z","steps":["trace[2017375706] 'process raft request' (duration: 357.463801ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.437446Z","caller":"traceutil/trace.go:171","msg":"trace[1585561317] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"357.882154ms","start":"2026-05-20T02:15:00.079527Z","end":"2026-05-20T02:15:00.437409Z","steps":["trace[1585561317] 'process raft request' (duration: 357.665998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:00.437529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:00.079799Z","time spent":"357.654437ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:15:00.437619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:00.079519Z","time spent":"358.006998ms","remote":"127.0.0.1:34444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:15:00.437644Z","caller":"traceutil/trace.go:171","msg":"trace[1235971986] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"209.349487ms","start":"2026-05-20T02:15:00.228283Z","end":"2026-05-20T02:15:00.437633Z","steps":["trace[1235971986] 'process raft request' (duration: 209.042458ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:00.43772Z","caller":"traceutil/trace.go:171","msg":"trace[212818732] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:713; }","duration":"225.481863ms","start":"2026-05-20T02:15:00.21222Z","end":"2026-05-20T02:15:00.437702Z","steps":["trace[212818732] 'read index received' (duration: 217.384194ms)","trace[212818732] 'applied index is now lower than readState.Index' (duration: 8.096579ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:15:00.437812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.586966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:15:00.437867Z","caller":"traceutil/trace.go:171","msg":"trace[459266398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:697; }","duration":"225.67371ms","start":"2026-05-20T02:15:00.21217Z","end":"2026-05-20T02:15:00.437843Z","steps":["trace[459266398] 'agreement among raft nodes before linearized reading' (duration: 225.597987ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:00.438044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:00.075814Z","time spent":"361.537416ms","remote":"127.0.0.1:34466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-20T02:15:09.040453Z","caller":"traceutil/trace.go:171","msg":"trace[677343093] linearizableReadLoop","detail":"{readStateIndex:801; appliedIndex:800; }","duration":"184.249707ms","start":"2026-05-20T02:15:08.856181Z","end":"2026-05-20T02:15:09.04043Z","steps":["trace[677343093] 'read index received' (duration: 184.101813ms)","trace[677343093] 'applied index is now lower than readState.Index' (duration: 146.924µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:15:09.040523Z","caller":"traceutil/trace.go:171","msg":"trace[1593138919] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"186.157702ms","start":"2026-05-20T02:15:08.854336Z","end":"2026-05-20T02:15:09.040493Z","steps":["trace[1593138919] 'process raft request' (duration: 185.966407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:09.040665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.470143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T02:15:09.040697Z","caller":"traceutil/trace.go:171","msg":"trace[554707116] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:776; }","duration":"184.526785ms","start":"2026-05-20T02:15:08.856162Z","end":"2026-05-20T02:15:09.040689Z","steps":["trace[554707116] 'agreement among raft nodes before linearized reading' (duration: 184.400861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:09.051931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.674379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-20T02:15:09.052139Z","caller":"traceutil/trace.go:171","msg":"trace[1546637377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:776; }","duration":"159.924796ms","start":"2026-05-20T02:15:08.892195Z","end":"2026-05-20T02:15:09.05212Z","steps":["trace[1546637377] 'agreement among raft nodes before linearized reading' (duration: 159.602237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:15.653881Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899356835752919,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T02:15:16.154652Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794899356835752919,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-20T02:15:16.253338Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.112781824s","expected-duration":"1s"} {"level":"info","ts":"2026-05-20T02:15:16.253856Z","caller":"traceutil/trace.go:171","msg":"trace[1328809287] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"1.100315586s","start":"2026-05-20T02:15:15.153511Z","end":"2026-05-20T02:15:16.253827Z","steps":["trace[1328809287] 'read index received' (duration: 1.099993847s)","trace[1328809287] 'applied index is now lower than readState.Index' (duration: 320.259µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:15:16.253941Z","caller":"traceutil/trace.go:171","msg":"trace[24059844] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"1.113489353s","start":"2026-05-20T02:15:15.140431Z","end":"2026-05-20T02:15:16.25392Z","steps":["trace[24059844] 'process raft request' (duration: 1.113215946s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:16.254099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100576503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vcm8c\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-05-20T02:15:16.254108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:15.140401Z","time spent":"1.113597487s","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:15:16.254145Z","caller":"traceutil/trace.go:171","msg":"trace[1848035619] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vcm8c; range_end:; response_count:1; response_revision:816; }","duration":"1.100666045s","start":"2026-05-20T02:15:15.153465Z","end":"2026-05-20T02:15:16.254131Z","steps":["trace[1848035619] 'agreement among raft nodes before linearized reading' (duration: 1.100505101s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:16.2542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:15.153442Z","time spent":"1.100749578s","remote":"127.0.0.1:34606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vcm8c\" "} {"level":"warn","ts":"2026-05-20T02:15:16.254261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.179556ms","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-05-20T02:15:16.25429Z","caller":"traceutil/trace.go:171","msg":"trace[686278001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"364.248208ms","start":"2026-05-20T02:15:15.890033Z","end":"2026-05-20T02:15:16.254282Z","steps":["trace[686278001] 'agreement among raft nodes before linearized reading' (duration: 364.148276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:16.254311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:15.890011Z","time spent":"364.29573ms","remote":"127.0.0.1:34698","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-05-20T02:15:16.254353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.941695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-20T02:15:16.254435Z","caller":"traceutil/trace.go:171","msg":"trace[250974862] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:816; }","duration":"107.081289ms","start":"2026-05-20T02:15:16.14732Z","end":"2026-05-20T02:15:16.254401Z","steps":["trace[250974862] 'agreement among raft nodes before linearized reading' (duration: 106.807841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:16.254425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.841241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-20T02:15:16.254497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.759673ms","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-05-20T02:15:16.254529Z","caller":"traceutil/trace.go:171","msg":"trace[1642690279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"114.023185ms","start":"2026-05-20T02:15:16.140484Z","end":"2026-05-20T02:15:16.254507Z","steps":["trace[1642690279] 'agreement among raft nodes before linearized reading' (duration: 113.682756ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:15:16.25454Z","caller":"traceutil/trace.go:171","msg":"trace[1023502153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"105.855705ms","start":"2026-05-20T02:15:16.148672Z","end":"2026-05-20T02:15:16.254527Z","steps":["trace[1023502153] 'agreement among raft nodes before linearized reading' (duration: 105.725871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:16.254669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040225893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:15:16.254708Z","caller":"traceutil/trace.go:171","msg":"trace[678308449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"1.040306354s","start":"2026-05-20T02:15:15.214388Z","end":"2026-05-20T02:15:16.254694Z","steps":["trace[678308449] 'agreement among raft nodes before linearized reading' (duration: 1.039697268s)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:16.254737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:15:15.214364Z","time spent":"1.040364886s","remote":"127.0.0.1:34378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-20T02:15:56.839728Z","caller":"traceutil/trace.go:171","msg":"trace[580134447] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"252.342712ms","start":"2026-05-20T02:15:56.587359Z","end":"2026-05-20T02:15:56.839702Z","steps":["trace[580134447] 'read index received' (duration: 252.104747ms)","trace[580134447] 'applied index is now lower than readState.Index' (duration: 237.005µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:15:56.84086Z","caller":"traceutil/trace.go:171","msg":"trace[395988913] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"264.477124ms","start":"2026-05-20T02:15:56.5763Z","end":"2026-05-20T02:15:56.840777Z","steps":["trace[395988913] 'process raft request' (duration: 263.245099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:56.840987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.638769ms","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-05-20T02:15:56.841031Z","caller":"traceutil/trace.go:171","msg":"trace[1229584775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"253.71731ms","start":"2026-05-20T02:15:56.587299Z","end":"2026-05-20T02:15:56.841016Z","steps":["trace[1229584775] 'agreement among raft nodes before linearized reading' (duration: 253.634819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:56.841301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.444313ms","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-05-20T02:15:56.841336Z","caller":"traceutil/trace.go:171","msg":"trace[1584732436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1080; }","duration":"165.547216ms","start":"2026-05-20T02:15:56.67578Z","end":"2026-05-20T02:15:56.841328Z","steps":["trace[1584732436] 'agreement among raft nodes before linearized reading' (duration: 165.419763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:56.841492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.25019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:15:56.841539Z","caller":"traceutil/trace.go:171","msg":"trace[1678722328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1080; }","duration":"166.324742ms","start":"2026-05-20T02:15:56.675206Z","end":"2026-05-20T02:15:56.841531Z","steps":["trace[1678722328] 'agreement among raft nodes before linearized reading' (duration: 166.23511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:15:56.840904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.77099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T02:15:56.841829Z","caller":"traceutil/trace.go:171","msg":"trace[369099407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1080; }","duration":"191.777751ms","start":"2026-05-20T02:15:56.650043Z","end":"2026-05-20T02:15:56.84182Z","steps":["trace[369099407] 'agreement among raft nodes before linearized reading' (duration: 190.712669ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:01.266781Z","caller":"traceutil/trace.go:171","msg":"trace[1700194453] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"313.941193ms","start":"2026-05-20T02:16:00.952815Z","end":"2026-05-20T02:16:01.266756Z","steps":["trace[1700194453] 'read index received' (duration: 313.770059ms)","trace[1700194453] 'applied index is now lower than readState.Index' (duration: 170.444µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:16:01.266814Z","caller":"traceutil/trace.go:171","msg":"trace[1945094961] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"393.877091ms","start":"2026-05-20T02:16:00.872917Z","end":"2026-05-20T02:16:01.266794Z","steps":["trace[1945094961] 'process raft request' (duration: 393.716747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:01.266965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:00.872882Z","time spent":"393.996573ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:16:01.267003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.184728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-20T02:16:01.267004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.80149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T02:16:01.267032Z","caller":"traceutil/trace.go:171","msg":"trace[2070871798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1094; }","duration":"314.276589ms","start":"2026-05-20T02:16:00.952747Z","end":"2026-05-20T02:16:01.267024Z","steps":["trace[2070871798] 'agreement among raft nodes before linearized reading' (duration: 314.150687ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:01.267036Z","caller":"traceutil/trace.go:171","msg":"trace[996902092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1094; }","duration":"312.945902ms","start":"2026-05-20T02:16:00.954083Z","end":"2026-05-20T02:16:01.267029Z","steps":["trace[996902092] 'agreement among raft nodes before linearized reading' (duration: 312.864161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:01.267056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:00.952726Z","time spent":"314.32157ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-20T02:16:01.267058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:00.954057Z","time spent":"312.995523ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-20T02:16:01.267155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.824435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:16:01.267194Z","caller":"traceutil/trace.go:171","msg":"trace[574572980] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1094; }","duration":"299.938988ms","start":"2026-05-20T02:16:00.967242Z","end":"2026-05-20T02:16:01.267181Z","steps":["trace[574572980] 'agreement among raft nodes before linearized reading' (duration: 299.875096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:01.267234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.796189ms","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-05-20T02:16:01.267269Z","caller":"traceutil/trace.go:171","msg":"trace[633482177] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1094; }","duration":"312.84697ms","start":"2026-05-20T02:16:00.954412Z","end":"2026-05-20T02:16:01.267259Z","steps":["trace[633482177] 'agreement among raft nodes before linearized reading' (duration: 312.762178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:01.267306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:00.954368Z","time spent":"312.923452ms","remote":"127.0.0.1:34698","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-05-20T02:16:01.26728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.715148ms","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-05-20T02:16:01.267362Z","caller":"traceutil/trace.go:171","msg":"trace[2021988992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"312.855471ms","start":"2026-05-20T02:16:00.954485Z","end":"2026-05-20T02:16:01.267341Z","steps":["trace[2021988992] 'agreement among raft nodes before linearized reading' (duration: 312.629256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:01.267406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:00.954463Z","time spent":"312.934192ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-20T02:16:01.793409Z","caller":"traceutil/trace.go:171","msg":"trace[1878895354] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"144.932899ms","start":"2026-05-20T02:16:01.648445Z","end":"2026-05-20T02:16:01.793378Z","steps":["trace[1878895354] 'process raft request' (duration: 144.722104ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:03.599213Z","caller":"traceutil/trace.go:171","msg":"trace[1955299926] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"257.901728ms","start":"2026-05-20T02:16:03.341271Z","end":"2026-05-20T02:16:03.599173Z","steps":["trace[1955299926] 'read index received' (duration: 257.636563ms)","trace[1955299926] 'applied index is now lower than readState.Index' (duration: 263.025µs)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:16:03.599312Z","caller":"traceutil/trace.go:171","msg":"trace[393304813] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"321.605337ms","start":"2026-05-20T02:16:03.277674Z","end":"2026-05-20T02:16:03.59928Z","steps":["trace[393304813] 'process raft request' (duration: 321.267971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:03.600345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.396479ms","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-05-20T02:16:03.600428Z","caller":"traceutil/trace.go:171","msg":"trace[369102828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1100; }","duration":"258.49263ms","start":"2026-05-20T02:16:03.341918Z","end":"2026-05-20T02:16:03.600411Z","steps":["trace[369102828] 'agreement among raft nodes before linearized reading' (duration: 258.317647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:03.60056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.406909ms","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-05-20T02:16:03.600607Z","caller":"traceutil/trace.go:171","msg":"trace[639732880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1100; }","duration":"258.528161ms","start":"2026-05-20T02:16:03.34207Z","end":"2026-05-20T02:16:03.600598Z","steps":["trace[639732880] 'agreement among raft nodes before linearized reading' (duration: 258.329347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:03.600641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.42579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-20T02:16:03.60079Z","caller":"traceutil/trace.go:171","msg":"trace[21521354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1100; }","duration":"258.635674ms","start":"2026-05-20T02:16:03.342106Z","end":"2026-05-20T02:16:03.600742Z","steps":["trace[21521354] 'agreement among raft nodes before linearized reading' (duration: 258.267127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:03.600042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.738636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:16:03.601101Z","caller":"traceutil/trace.go:171","msg":"trace[1709418218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1100; }","duration":"259.897019ms","start":"2026-05-20T02:16:03.341193Z","end":"2026-05-20T02:16:03.60109Z","steps":["trace[1709418218] 'agreement among raft nodes before linearized reading' (duration: 258.188305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:03.603118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:03.277659Z","time spent":"322.590528ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-20T02:16:03.768487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.876768ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-05-20T02:16:03.768897Z","caller":"traceutil/trace.go:171","msg":"trace[925844264] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"161.82031ms","start":"2026-05-20T02:16:03.607054Z","end":"2026-05-20T02:16:03.768875Z","steps":["trace[925844264] 'process raft request' (duration: 161.774839ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:03.769047Z","caller":"traceutil/trace.go:171","msg":"trace[381223411] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"162.153796ms","start":"2026-05-20T02:16:03.606869Z","end":"2026-05-20T02:16:03.769023Z","steps":["trace[381223411] 'process raft request' (duration: 161.914461ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:03.769068Z","caller":"traceutil/trace.go:171","msg":"trace[73313131] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"162.120555ms","start":"2026-05-20T02:16:03.606821Z","end":"2026-05-20T02:16:03.768942Z","steps":["trace[73313131] 'process raft request' (duration: 161.928051ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:03.769308Z","caller":"traceutil/trace.go:171","msg":"trace[341363684] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"162.191077ms","start":"2026-05-20T02:16:03.606725Z","end":"2026-05-20T02:16:03.768916Z","steps":["trace[341363684] 'process raft request' (duration: 161.88833ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:04.109317Z","caller":"traceutil/trace.go:171","msg":"trace[276674422] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"309.728239ms","start":"2026-05-20T02:16:03.79955Z","end":"2026-05-20T02:16:04.109278Z","steps":["trace[276674422] 'process raft request' (duration: 300.589177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:04.109476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:16:03.799502Z","time spent":"309.894681ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:16:04.101038Z","caller":"traceutil/trace.go:171","msg":"trace[1301931343] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"261.727366ms","start":"2026-05-20T02:16:03.839277Z","end":"2026-05-20T02:16:04.101004Z","steps":["trace[1301931343] 'read index received' (duration: 260.764117ms)","trace[1301931343] 'applied index is now lower than readState.Index' (duration: 961.649µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:16:04.110128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.865498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-20T02:16:04.111566Z","caller":"traceutil/trace.go:171","msg":"trace[1839526434] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1106; }","duration":"272.322387ms","start":"2026-05-20T02:16:03.839206Z","end":"2026-05-20T02:16:04.111529Z","steps":["trace[1839526434] 'agreement among raft nodes before linearized reading' (duration: 261.856118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:04.11349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.103964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T02:16:04.113533Z","caller":"traceutil/trace.go:171","msg":"trace[1780810524] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1106; }","duration":"164.188576ms","start":"2026-05-20T02:16:03.949334Z","end":"2026-05-20T02:16:04.113523Z","steps":["trace[1780810524] 'agreement among raft nodes before linearized reading' (duration: 164.123015ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:14.054174Z","caller":"traceutil/trace.go:171","msg":"trace[640299888] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"108.010936ms","start":"2026-05-20T02:16:13.946116Z","end":"2026-05-20T02:16:14.054127Z","steps":["trace[640299888] 'process raft request' (duration: 107.505306ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:16.356151Z","caller":"traceutil/trace.go:171","msg":"trace[842337852] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"175.546081ms","start":"2026-05-20T02:16:16.180561Z","end":"2026-05-20T02:16:16.356107Z","steps":["trace[842337852] 'process raft request' (duration: 128.925619ms)","trace[842337852] 'compare' (duration: 46.413398ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:16:16.356189Z","caller":"traceutil/trace.go:171","msg":"trace[1628508627] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"144.118926ms","start":"2026-05-20T02:16:16.212033Z","end":"2026-05-20T02:16:16.356152Z","steps":["trace[1628508627] 'read index received' (duration: 97.466313ms)","trace[1628508627] 'applied index is now lower than readState.Index' (duration: 46.649943ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:16:16.356407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.344952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:16:16.356447Z","caller":"traceutil/trace.go:171","msg":"trace[144465140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1144; }","duration":"143.419573ms","start":"2026-05-20T02:16:16.213013Z","end":"2026-05-20T02:16:16.356432Z","steps":["trace[144465140] 'agreement among raft nodes before linearized reading' (duration: 143.316541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:16.356436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.37181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-20T02:16:16.356529Z","caller":"traceutil/trace.go:171","msg":"trace[2026144552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1144; }","duration":"144.490213ms","start":"2026-05-20T02:16:16.212013Z","end":"2026-05-20T02:16:16.356504Z","steps":["trace[2026144552] 'agreement among raft nodes before linearized reading' (duration: 144.274419ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:18.214756Z","caller":"traceutil/trace.go:171","msg":"trace[2140853045] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"112.815387ms","start":"2026-05-20T02:16:18.1019Z","end":"2026-05-20T02:16:18.214715Z","steps":["trace[2140853045] 'process raft request' (duration: 112.612793ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:18.824357Z","caller":"traceutil/trace.go:171","msg":"trace[538391836] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"109.602986ms","start":"2026-05-20T02:16:18.714714Z","end":"2026-05-20T02:16:18.824317Z","steps":["trace[538391836] 'process raft request' (duration: 109.391372ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:22.49378Z","caller":"traceutil/trace.go:171","msg":"trace[167032317] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"148.109292ms","start":"2026-05-20T02:16:22.345636Z","end":"2026-05-20T02:16:22.493746Z","steps":["trace[167032317] 'process raft request' (duration: 73.078457ms)","trace[167032317] 'compare' (duration: 74.720909ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:16:22.675116Z","caller":"traceutil/trace.go:171","msg":"trace[791881460] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"159.776628ms","start":"2026-05-20T02:16:22.515308Z","end":"2026-05-20T02:16:22.675085Z","steps":["trace[791881460] 'read index received' (duration: 94.037225ms)","trace[791881460] 'applied index is now lower than readState.Index' (duration: 65.738453ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:16:22.675259Z","caller":"traceutil/trace.go:171","msg":"trace[1056937502] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"176.66388ms","start":"2026-05-20T02:16:22.498583Z","end":"2026-05-20T02:16:22.675247Z","steps":["trace[1056937502] 'process raft request' (duration: 110.855206ms)","trace[1056937502] 'compare' (duration: 65.509119ms)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:16:22.675485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.169286ms","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-05-20T02:16:22.675516Z","caller":"traceutil/trace.go:171","msg":"trace[333468367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1164; }","duration":"160.256527ms","start":"2026-05-20T02:16:22.515251Z","end":"2026-05-20T02:16:22.675507Z","steps":["trace[333468367] 'agreement among raft nodes before linearized reading' (duration: 160.120524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:22.675599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.598341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:16:22.675656Z","caller":"traceutil/trace.go:171","msg":"trace[1155109171] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1164; }","duration":"110.661282ms","start":"2026-05-20T02:16:22.564977Z","end":"2026-05-20T02:16:22.675639Z","steps":["trace[1155109171] 'agreement among raft nodes before linearized reading' (duration: 110.580151ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:16:24.613719Z","caller":"traceutil/trace.go:171","msg":"trace[277178295] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"112.481929ms","start":"2026-05-20T02:16:24.501213Z","end":"2026-05-20T02:16:24.613695Z","steps":["trace[277178295] 'process raft request' (duration: 112.330276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:29.263445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.530555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-20T02:16:29.264084Z","caller":"traceutil/trace.go:171","msg":"trace[1573250141] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1185; }","duration":"156.878109ms","start":"2026-05-20T02:16:29.107186Z","end":"2026-05-20T02:16:29.264064Z","steps":["trace[1573250141] 'count revisions from in-memory index tree' (duration: 155.412662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:16:29.342977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.277229ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-20T02:17:09.622344Z","caller":"traceutil/trace.go:171","msg":"trace[1801545852] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"110.418758ms","start":"2026-05-20T02:17:09.511889Z","end":"2026-05-20T02:17:09.622308Z","steps":["trace[1801545852] 'process raft request' (duration: 110.184255ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:17:17.207868Z","caller":"traceutil/trace.go:171","msg":"trace[1183914497] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1432; }","duration":"187.863099ms","start":"2026-05-20T02:17:17.019985Z","end":"2026-05-20T02:17:17.207848Z","steps":["trace[1183914497] 'read index received' (duration: 187.683976ms)","trace[1183914497] 'applied index is now lower than readState.Index' (duration: 178.403µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:17:17.208021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.006751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-20T02:17:17.208053Z","caller":"traceutil/trace.go:171","msg":"trace[1753586472] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1378; }","duration":"188.063392ms","start":"2026-05-20T02:17:17.019978Z","end":"2026-05-20T02:17:17.208042Z","steps":["trace[1753586472] 'agreement among raft nodes before linearized reading' (duration: 187.974041ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:17:17.207921Z","caller":"traceutil/trace.go:171","msg":"trace[2055389281] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"357.79127ms","start":"2026-05-20T02:17:16.850089Z","end":"2026-05-20T02:17:17.207881Z","steps":["trace[2055389281] 'process raft request' (duration: 357.633958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:17:17.208438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-20T02:17:16.850055Z","time spent":"358.215048ms","remote":"127.0.0.1:34698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-20T02:17:17.375112Z","caller":"traceutil/trace.go:171","msg":"trace[64799858] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"160.311455ms","start":"2026-05-20T02:17:17.214766Z","end":"2026-05-20T02:17:17.375078Z","steps":["trace[64799858] 'process raft request' (duration: 82.966946ms)","trace[64799858] 'compare' (duration: 77.191426ms)"],"step_count":2} {"level":"info","ts":"2026-05-20T02:17:17.394099Z","caller":"traceutil/trace.go:171","msg":"trace[443840820] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"177.917622ms","start":"2026-05-20T02:17:17.216163Z","end":"2026-05-20T02:17:17.39408Z","steps":["trace[443840820] 'process raft request' (duration: 177.78804ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:17:17.394375Z","caller":"traceutil/trace.go:171","msg":"trace[1509821284] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"176.45299ms","start":"2026-05-20T02:17:17.21789Z","end":"2026-05-20T02:17:17.394343Z","steps":["trace[1509821284] 'process raft request' (duration: 176.150545ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:17:18.689913Z","caller":"traceutil/trace.go:171","msg":"trace[1656215588] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"281.485815ms","start":"2026-05-20T02:17:18.408403Z","end":"2026-05-20T02:17:18.689889Z","steps":["trace[1656215588] 'process raft request' (duration: 281.320642ms)"],"step_count":1} {"level":"info","ts":"2026-05-20T02:17:53.704281Z","caller":"traceutil/trace.go:171","msg":"trace[1729792944] linearizableReadLoop","detail":"{readStateIndex:1567; appliedIndex:1566; }","duration":"133.465549ms","start":"2026-05-20T02:17:53.570794Z","end":"2026-05-20T02:17:53.704259Z","steps":["trace[1729792944] 'read index received' (duration: 133.274036ms)","trace[1729792944] 'applied index is now lower than readState.Index' (duration: 190.043µs)"],"step_count":2} {"level":"warn","ts":"2026-05-20T02:17:53.704545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.376778ms","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-05-20T02:17:53.704576Z","caller":"traceutil/trace.go:171","msg":"trace[1764509038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1503; }","duration":"127.45477ms","start":"2026-05-20T02:17:53.577114Z","end":"2026-05-20T02:17:53.704569Z","steps":["trace[1764509038] 'agreement among raft nodes before linearized reading' (duration: 127.270597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:17:53.70466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.13014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-20T02:17:53.704733Z","caller":"traceutil/trace.go:171","msg":"trace[1394674094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1503; }","duration":"120.277013ms","start":"2026-05-20T02:17:53.584435Z","end":"2026-05-20T02:17:53.704712Z","steps":["trace[1394674094] 'agreement among raft nodes before linearized reading' (duration: 120.035299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-20T02:17:53.704661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.697652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8jm8p\" ","response":"range_response_count:1 size:18521"} {"level":"info","ts":"2026-05-20T02:17:53.704818Z","caller":"traceutil/trace.go:171","msg":"trace[471161557] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8jm8p; range_end:; response_count:1; response_revision:1503; }","duration":"134.034617ms","start":"2026-05-20T02:17:53.570775Z","end":"2026-05-20T02:17:53.70481Z","steps":["trace[471161557] 'agreement among raft nodes before linearized reading' (duration: 133.56735ms)"],"step_count":1}