{"level":"warn","ts":"2026-05-11T10:44:06.033561Z","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-11T10:44:06.033667Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.90: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.19.213.90:2380","--initial-cluster=instance=https://199.19.213.90:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.90:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.90: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-11T10:44:06.033756Z","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-11T10:44:06.033771Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.90:2380"]} {"level":"info","ts":"2026-05-11T10:44:06.033795Z","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-11T10:44:06.034458Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.90:2379"]} {"level":"info","ts":"2026-05-11T10:44:06.034543Z","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.19.213.90:2380"],"listen-peer-urls":["https://199.19.213.90:2380"],"advertise-client-urls":["https://199.19.213.90:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.90:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.90: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-11T10:44:06.413833Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"379.040074ms"} {"level":"info","ts":"2026-05-11T10:44:07.250137Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2b21fdc9c735cc27","cluster-id":"77163f3b44f8f1db"} {"level":"info","ts":"2026-05-11T10:44:07.250329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T10:44:07.250429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became follower at term 0"} {"level":"info","ts":"2026-05-11T10:44:07.250501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2b21fdc9c735cc27 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T10:44:07.250569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became follower at term 1"} {"level":"info","ts":"2026-05-11T10:44:07.250686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 switched to configuration voters=(3108044260934798375)"} {"level":"warn","ts":"2026-05-11T10:44:07.803753Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T10:44:07.997092Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T10:44:08.152737Z","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-11T10:44:08.330137Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2b21fdc9c735cc27","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T10:44:08.330508Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2b21fdc9c735cc27","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T10:44:08.330611Z","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-11T10:44:08.330764Z","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-11T10:44:08.330776Z","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-11T10:44:08.336379Z","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-11T10:44:08.336509Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.90:2380"} {"level":"info","ts":"2026-05-11T10:44:08.336555Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.90:2380"} {"level":"info","ts":"2026-05-11T10:44:08.336841Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2b21fdc9c735cc27","initial-advertise-peer-urls":["https://199.19.213.90:2380"],"listen-peer-urls":["https://199.19.213.90:2380"],"advertise-client-urls":["https://199.19.213.90:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.90:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T10:44:08.336935Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T10:44:08.401946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 switched to configuration voters=(3108044260934798375)"} {"level":"info","ts":"2026-05-11T10:44:08.40216Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"77163f3b44f8f1db","local-member-id":"2b21fdc9c735cc27","added-peer-id":"2b21fdc9c735cc27","added-peer-peer-urls":["https://199.19.213.90:2380"]} {"level":"info","ts":"2026-05-11T10:44:09.195004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T10:44:09.195075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T10:44:09.195128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 received MsgPreVoteResp from 2b21fdc9c735cc27 at term 1"} {"level":"info","ts":"2026-05-11T10:44:09.195149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became candidate at term 2"} {"level":"info","ts":"2026-05-11T10:44:09.19516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 received MsgVoteResp from 2b21fdc9c735cc27 at term 2"} {"level":"info","ts":"2026-05-11T10:44:09.195176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2b21fdc9c735cc27 became leader at term 2"} {"level":"info","ts":"2026-05-11T10:44:09.195189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2b21fdc9c735cc27 elected leader 2b21fdc9c735cc27 at term 2"} {"level":"info","ts":"2026-05-11T10:44:09.419684Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:44:09.510383Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:44:09.510412Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:44:09.5113Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T10:44:09.511356Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T10:44:09.510351Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2b21fdc9c735cc27","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.90:2379]}","request-path":"/0/members/2b21fdc9c735cc27/attributes","cluster-id":"77163f3b44f8f1db","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T10:44:09.513265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T10:44:09.516178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.90:2379"} {"level":"info","ts":"2026-05-11T10:44:09.564373Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"77163f3b44f8f1db","local-member-id":"2b21fdc9c735cc27","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:44:09.564596Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:44:09.564687Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-11T10:44:09.767407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.202817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:09.767517Z","caller":"traceutil/trace.go:171","msg":"trace[1925341334] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"148.588047ms","start":"2026-05-11T10:44:09.618912Z","end":"2026-05-11T10:44:09.7675Z","steps":["trace[1925341334] 'count revisions from in-memory index tree' (duration: 148.142573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:09.767657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.74336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:09.767706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.302231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:09.767763Z","caller":"traceutil/trace.go:171","msg":"trace[437497876] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"100.88034ms","start":"2026-05-11T10:44:09.66686Z","end":"2026-05-11T10:44:09.76774Z","steps":["trace[437497876] 'range keys from in-memory index tree' (duration: 100.61707ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:09.767786Z","caller":"traceutil/trace.go:171","msg":"trace[1672310097] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"133.405359ms","start":"2026-05-11T10:44:09.634362Z","end":"2026-05-11T10:44:09.767768Z","steps":["trace[1672310097] 'count revisions from in-memory index tree' (duration: 133.198493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:09.767972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.845213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:09.768016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.317078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:09.768047Z","caller":"traceutil/trace.go:171","msg":"trace[380503012] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"134.379264ms","start":"2026-05-11T10:44:09.633658Z","end":"2026-05-11T10:44:09.768037Z","steps":["trace[380503012] 'range keys from in-memory index tree' (duration: 134.253514ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:09.768014Z","caller":"traceutil/trace.go:171","msg":"trace[1222750363] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"109.912299ms","start":"2026-05-11T10:44:09.658093Z","end":"2026-05-11T10:44:09.768005Z","steps":["trace[1222750363] 'count revisions from in-memory index tree' (duration: 109.79484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:09.767973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.072994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:09.768364Z","caller":"traceutil/trace.go:171","msg":"trace[1254025981] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"149.502137ms","start":"2026-05-11T10:44:09.618853Z","end":"2026-05-11T10:44:09.768355Z","steps":["trace[1254025981] 'range keys from in-memory index tree' (duration: 148.905611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:09.768831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.882347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:09.769032Z","caller":"traceutil/trace.go:171","msg":"trace[1520780058] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"102.060541ms","start":"2026-05-11T10:44:09.666878Z","end":"2026-05-11T10:44:09.768938Z","steps":["trace[1520780058] 'count revisions from in-memory index tree' (duration: 101.743477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:09.769692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.021197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:09.769802Z","caller":"traceutil/trace.go:171","msg":"trace[1615504242] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"120.088444ms","start":"2026-05-11T10:44:09.649688Z","end":"2026-05-11T10:44:09.769776Z","steps":["trace[1615504242] 'range keys from in-memory index tree' (duration: 117.904108ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:10.992092Z","caller":"traceutil/trace.go:171","msg":"trace[1481242009] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"156.079925ms","start":"2026-05-11T10:44:10.835979Z","end":"2026-05-11T10:44:10.992059Z","steps":["trace[1481242009] 'process raft request' (duration: 155.411484ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313269Z","caller":"traceutil/trace.go:171","msg":"trace[1990078344] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"463.99514ms","start":"2026-05-11T10:44:10.849238Z","end":"2026-05-11T10:44:11.313233Z","steps":["trace[1990078344] 'process raft request' (duration: 463.87176ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313321Z","caller":"traceutil/trace.go:171","msg":"trace[2026480966] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"474.309637ms","start":"2026-05-11T10:44:10.838952Z","end":"2026-05-11T10:44:11.313262Z","steps":["trace[2026480966] 'process raft request' (duration: 473.856692ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313378Z","caller":"traceutil/trace.go:171","msg":"trace[1513153834] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"417.013463ms","start":"2026-05-11T10:44:10.896343Z","end":"2026-05-11T10:44:11.313356Z","steps":["trace[1513153834] 'process raft request' (duration: 416.821358ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313518Z","caller":"traceutil/trace.go:171","msg":"trace[1085588310] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"470.637797ms","start":"2026-05-11T10:44:10.84286Z","end":"2026-05-11T10:44:11.313498Z","steps":["trace[1085588310] 'read index received' (duration: 148.355167ms)","trace[1085588310] 'applied index is now lower than readState.Index' (duration: 322.27982ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:11.313612Z","caller":"traceutil/trace.go:171","msg":"trace[779824236] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"416.566638ms","start":"2026-05-11T10:44:10.897032Z","end":"2026-05-11T10:44:11.313599Z","steps":["trace[779824236] 'process raft request' (duration: 416.32994ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313628Z","caller":"traceutil/trace.go:171","msg":"trace[1712278177] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"416.540056ms","start":"2026-05-11T10:44:10.897076Z","end":"2026-05-11T10:44:11.313616Z","steps":["trace[1712278177] 'process raft request' (duration: 416.33606ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313639Z","caller":"traceutil/trace.go:171","msg":"trace[1073063472] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"416.626193ms","start":"2026-05-11T10:44:10.896976Z","end":"2026-05-11T10:44:11.313602Z","steps":["trace[1073063472] 'process raft request' (duration: 416.225452ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313691Z","caller":"traceutil/trace.go:171","msg":"trace[1458298716] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"416.676047ms","start":"2026-05-11T10:44:10.897004Z","end":"2026-05-11T10:44:11.31368Z","steps":["trace[1458298716] 'process raft request' (duration: 416.234453ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.313772Z","caller":"traceutil/trace.go:171","msg":"trace[2087156775] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"416.742052ms","start":"2026-05-11T10:44:10.89701Z","end":"2026-05-11T10:44:11.313752Z","steps":["trace[2087156775] 'process raft request' (duration: 416.288058ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.31385Z","caller":"traceutil/trace.go:171","msg":"trace[1767129273] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"402.210002ms","start":"2026-05-11T10:44:10.91162Z","end":"2026-05-11T10:44:11.31383Z","steps":["trace[1767129273] 'process raft request' (duration: 401.837364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.313959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.849226Z","time spent":"464.147451ms","remote":"127.0.0.1:53822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.313994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.751457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.314064Z","caller":"traceutil/trace.go:171","msg":"trace[547765941] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"434.854714ms","start":"2026-05-11T10:44:10.879191Z","end":"2026-05-11T10:44:11.314046Z","steps":["trace[547765941] 'agreement among raft nodes before linearized reading' (duration: 434.689252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.314091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.222731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:11.314106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.776443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.314138Z","caller":"traceutil/trace.go:171","msg":"trace[1799364487] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"471.296106ms","start":"2026-05-11T10:44:10.842828Z","end":"2026-05-11T10:44:11.314124Z","steps":["trace[1799364487] 'agreement among raft nodes before linearized reading' (duration: 471.221011ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.314152Z","caller":"traceutil/trace.go:171","msg":"trace[918880087] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"367.857249ms","start":"2026-05-11T10:44:10.946281Z","end":"2026-05-11T10:44:11.314138Z","steps":["trace[918880087] 'agreement among raft nodes before linearized reading' (duration: 367.788454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.314187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.842817Z","time spent":"471.358911ms","remote":"127.0.0.1:53936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-11T10:44:11.314166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.860273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:11.314193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.118347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.314263Z","caller":"traceutil/trace.go:171","msg":"trace[192467647] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"418.973702ms","start":"2026-05-11T10:44:10.895277Z","end":"2026-05-11T10:44:11.314251Z","steps":["trace[192467647] 'agreement among raft nodes before linearized reading' (duration: 418.861033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.314275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.702437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.90\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:11.314304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.895267Z","time spent":"419.027455ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-11T10:44:11.314314Z","caller":"traceutil/trace.go:171","msg":"trace[1965343340] range","detail":"{range_begin:/registry/masterleases/199.19.213.90; range_end:; response_count:0; response_revision:11; }","duration":"419.811535ms","start":"2026-05-11T10:44:10.894491Z","end":"2026-05-11T10:44:11.314303Z","steps":["trace[1965343340] 'agreement among raft nodes before linearized reading' (duration: 419.737759ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.314293Z","caller":"traceutil/trace.go:171","msg":"trace[570183807] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"418.254697ms","start":"2026-05-11T10:44:10.896023Z","end":"2026-05-11T10:44:11.314278Z","steps":["trace[570183807] 'agreement among raft nodes before linearized reading' (duration: 417.994217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.314357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.894474Z","time spent":"419.86923ms","remote":"127.0.0.1:53582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.19.213.90\" "} {"level":"warn","ts":"2026-05-11T10:44:11.314305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.897065Z","time spent":"416.630703ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.314113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.879179Z","time spent":"434.92228ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-11T10:44:11.314371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.896011Z","time spent":"418.347944ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-11T10:44:11.3143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.896961Z","time spent":"416.741132ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.314191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.946261Z","time spent":"367.920354ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-11T10:44:11.31394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.896971Z","time spent":"416.837389ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.314373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.896981Z","time spent":"416.737131ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.314623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.838927Z","time spent":"474.516223ms","remote":"127.0.0.1:53614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:11.314693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.896305Z","time spent":"417.195046ms","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.314833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.897017Z","time spent":"416.649895ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.313968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:10.911601Z","time spent":"402.285467ms","remote":"127.0.0.1:53748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.962183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.406188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:11.962443Z","caller":"traceutil/trace.go:171","msg":"trace[1649861255] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"644.484696ms","start":"2026-05-11T10:44:11.317905Z","end":"2026-05-11T10:44:11.962389Z","steps":["trace[1649861255] 'process raft request' (duration: 128.672488ms)","trace[1649861255] 'compare' (duration: 515.265477ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:11.962633Z","caller":"traceutil/trace.go:171","msg":"trace[1050605251] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"642.373484ms","start":"2026-05-11T10:44:11.320214Z","end":"2026-05-11T10:44:11.962587Z","steps":["trace[1050605251] 'process raft request' (duration: 642.098423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.962614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.317877Z","time spent":"644.658919ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:11.962665Z","caller":"traceutil/trace.go:171","msg":"trace[131456391] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:14; }","duration":"642.45087ms","start":"2026-05-11T10:44:11.320189Z","end":"2026-05-11T10:44:11.96264Z","steps":["trace[131456391] 'read index received' (duration: 126.406604ms)","trace[131456391] 'applied index is now lower than readState.Index' (duration: 516.042946ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:11.962737Z","caller":"traceutil/trace.go:171","msg":"trace[1777232689] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"642.572459ms","start":"2026-05-11T10:44:11.320148Z","end":"2026-05-11T10:44:11.96272Z","steps":["trace[1777232689] 'process raft request' (duration: 642.133536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.963366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.320124Z","time spent":"643.172575ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.963638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.433375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-05-11T10:44:11.963678Z","caller":"traceutil/trace.go:171","msg":"trace[1274553229] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"643.509021ms","start":"2026-05-11T10:44:11.320153Z","end":"2026-05-11T10:44:11.963662Z","steps":["trace[1274553229] 'agreement among raft nodes before linearized reading' (duration: 643.410833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.96371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.32014Z","time spent":"643.564185ms","remote":"127.0.0.1:53748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3512,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-11T10:44:11.96277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.56993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.963853Z","caller":"traceutil/trace.go:171","msg":"trace[1562946804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"643.689995ms","start":"2026-05-11T10:44:11.320153Z","end":"2026-05-11T10:44:11.963843Z","steps":["trace[1562946804] 'agreement among raft nodes before linearized reading' (duration: 642.551228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.963944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.320131Z","time spent":"643.799763ms","remote":"127.0.0.1:53538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-11T10:44:11.96422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.784449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-11T10:44:11.964281Z","caller":"traceutil/trace.go:171","msg":"trace[1760853410] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"263.887276ms","start":"2026-05-11T10:44:11.700377Z","end":"2026-05-11T10:44:11.964265Z","steps":["trace[1760853410] 'agreement among raft nodes before linearized reading' (duration: 263.761886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.964377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.530898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.964409Z","caller":"traceutil/trace.go:171","msg":"trace[289160305] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:19; }","duration":"365.603783ms","start":"2026-05-11T10:44:11.598795Z","end":"2026-05-11T10:44:11.964399Z","steps":["trace[289160305] 'agreement among raft nodes before linearized reading' (duration: 365.554519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.964437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.598774Z","time spent":"365.657288ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-11T10:44:11.964528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.178798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:11.964557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.482548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.964564Z","caller":"traceutil/trace.go:171","msg":"trace[1250166128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"109.263424ms","start":"2026-05-11T10:44:11.85529Z","end":"2026-05-11T10:44:11.964553Z","steps":["trace[1250166128] 'agreement among raft nodes before linearized reading' (duration: 109.197029ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.964586Z","caller":"traceutil/trace.go:171","msg":"trace[1663977076] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"443.585406ms","start":"2026-05-11T10:44:11.520991Z","end":"2026-05-11T10:44:11.964576Z","steps":["trace[1663977076] 'agreement among raft nodes before linearized reading' (duration: 443.544373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.964613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.520922Z","time spent":"443.685604ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-11T10:44:11.964739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.09868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:11.964768Z","caller":"traceutil/trace.go:171","msg":"trace[126495640] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"169.143403ms","start":"2026-05-11T10:44:11.795616Z","end":"2026-05-11T10:44:11.964759Z","steps":["trace[126495640] 'agreement among raft nodes before linearized reading' (duration: 169.09384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.964774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.637473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-11T10:44:11.964802Z","caller":"traceutil/trace.go:171","msg":"trace[274191984] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"589.690547ms","start":"2026-05-11T10:44:11.375103Z","end":"2026-05-11T10:44:11.964794Z","steps":["trace[274191984] 'agreement among raft nodes before linearized reading' (duration: 589.638423ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.962811Z","caller":"traceutil/trace.go:171","msg":"trace[193466827] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"642.331692ms","start":"2026-05-11T10:44:11.320459Z","end":"2026-05-11T10:44:11.96279Z","steps":["trace[193466827] 'process raft request' (duration: 642.031669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.964925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.32045Z","time spent":"644.420501ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.964828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.375066Z","time spent":"589.756312ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-11T10:44:11.962815Z","caller":"traceutil/trace.go:171","msg":"trace[2057222183] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"637.698828ms","start":"2026-05-11T10:44:11.325105Z","end":"2026-05-11T10:44:11.962804Z","steps":["trace[2057222183] 'process raft request' (duration: 637.47161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.965175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.325092Z","time spent":"640.020935ms","remote":"127.0.0.1:53748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:11.965195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.000049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-fwgnr\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-05-11T10:44:11.965267Z","caller":"traceutil/trace.go:171","msg":"trace[1664011190] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-fwgnr; range_end:; response_count:1; response_revision:19; }","duration":"644.095976ms","start":"2026-05-11T10:44:11.321148Z","end":"2026-05-11T10:44:11.965243Z","steps":["trace[1664011190] 'agreement among raft nodes before linearized reading' (duration: 643.966856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.965322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.321136Z","time spent":"644.173772ms","remote":"127.0.0.1:53822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":883,"request content":"key:\"/registry/certificatesigningrequests/csr-fwgnr\" "} {"level":"warn","ts":"2026-05-11T10:44:11.965322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.159196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:11.962823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.320193Z","time spent":"642.535697ms","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:11.962858Z","caller":"traceutil/trace.go:171","msg":"trace[1345688292] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"642.560849ms","start":"2026-05-11T10:44:11.320289Z","end":"2026-05-11T10:44:11.96285Z","steps":["trace[1345688292] 'process raft request' (duration: 642.130026ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.962862Z","caller":"traceutil/trace.go:171","msg":"trace[863574974] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"642.558359ms","start":"2026-05-11T10:44:11.320291Z","end":"2026-05-11T10:44:11.96285Z","steps":["trace[863574974] 'process raft request' (duration: 642.087423ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.962892Z","caller":"traceutil/trace.go:171","msg":"trace[1051669121] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"641.881537ms","start":"2026-05-11T10:44:11.320997Z","end":"2026-05-11T10:44:11.962879Z","steps":["trace[1051669121] 'process raft request' (duration: 641.533541ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:11.9629Z","caller":"traceutil/trace.go:171","msg":"trace[1114827299] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"642.563179ms","start":"2026-05-11T10:44:11.32033Z","end":"2026-05-11T10:44:11.962893Z","steps":["trace[1114827299] 'process raft request' (duration: 642.130106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.965453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.320319Z","time spent":"645.093622ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:11.965567Z","caller":"traceutil/trace.go:171","msg":"trace[1514563687] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"171.441458ms","start":"2026-05-11T10:44:11.794112Z","end":"2026-05-11T10:44:11.965554Z","steps":["trace[1514563687] 'agreement among raft nodes before linearized reading' (duration: 171.153586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:11.965641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.32028Z","time spent":"645.302058ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.965686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.320983Z","time spent":"644.66283ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:11.965775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.320275Z","time spent":"645.440399ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.430147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.989449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:12.4304Z","caller":"traceutil/trace.go:171","msg":"trace[284541237] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"458.503313ms","start":"2026-05-11T10:44:11.97184Z","end":"2026-05-11T10:44:12.430343Z","steps":["trace[284541237] 'process raft request' (duration: 225.246684ms)","trace[284541237] 'compare' (duration: 232.819286ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:12.430555Z","caller":"traceutil/trace.go:171","msg":"trace[1104867067] linearizableReadLoop","detail":"{readStateIndex:29; appliedIndex:23; }","duration":"458.449569ms","start":"2026-05-11T10:44:11.972086Z","end":"2026-05-11T10:44:12.430535Z","steps":["trace[1104867067] 'read index received' (duration: 19.013494ms)","trace[1104867067] 'applied index is now lower than readState.Index' (duration: 439.435135ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:12.430608Z","caller":"traceutil/trace.go:171","msg":"trace[1238619467] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"458.73031ms","start":"2026-05-11T10:44:11.971846Z","end":"2026-05-11T10:44:12.430576Z","steps":["trace[1238619467] 'process raft request' (duration: 458.420776ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.430749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.971819Z","time spent":"458.86571ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.430832Z","caller":"traceutil/trace.go:171","msg":"trace[1666774902] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"458.85666ms","start":"2026-05-11T10:44:11.971961Z","end":"2026-05-11T10:44:12.430818Z","steps":["trace[1666774902] 'process raft request' (duration: 458.391905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.430897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.971953Z","time spent":"458.918894ms","remote":"127.0.0.1:53936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.430651Z","caller":"traceutil/trace.go:171","msg":"trace[186619420] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"458.681447ms","start":"2026-05-11T10:44:11.97196Z","end":"2026-05-11T10:44:12.430641Z","steps":["trace[186619420] 'process raft request' (duration: 458.359252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.430987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.97181Z","time spent":"458.798475ms","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.431021Z","caller":"traceutil/trace.go:171","msg":"trace[740458332] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"458.982529ms","start":"2026-05-11T10:44:11.972031Z","end":"2026-05-11T10:44:12.431013Z","steps":["trace[740458332] 'process raft request' (duration: 458.349081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.432147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972023Z","time spent":"460.065762ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.431014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.97195Z","time spent":"459.022912ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.431129Z","caller":"traceutil/trace.go:171","msg":"trace[16376928] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"459.040933ms","start":"2026-05-11T10:44:11.97208Z","end":"2026-05-11T10:44:12.431121Z","steps":["trace[16376928] 'process raft request' (duration: 458.327129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.432624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972064Z","time spent":"460.518258ms","remote":"127.0.0.1:53674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.431162Z","caller":"traceutil/trace.go:171","msg":"trace[1960339303] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"458.545006ms","start":"2026-05-11T10:44:11.972611Z","end":"2026-05-11T10:44:12.431156Z","steps":["trace[1960339303] 'process raft request' (duration: 457.822851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.432854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972603Z","time spent":"460.15872ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.431187Z","caller":"traceutil/trace.go:171","msg":"trace[2033340568] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"457.741944ms","start":"2026-05-11T10:44:11.973439Z","end":"2026-05-11T10:44:12.431181Z","steps":["trace[2033340568] 'process raft request' (duration: 457.025429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.432968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.973432Z","time spent":"459.497108ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.431213Z","caller":"traceutil/trace.go:171","msg":"trace[1992562377] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"457.514977ms","start":"2026-05-11T10:44:11.973692Z","end":"2026-05-11T10:44:12.431207Z","steps":["trace[1992562377] 'process raft request' (duration: 456.801393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.433209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.973686Z","time spent":"459.479887ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.431302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.206746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.433349Z","caller":"traceutil/trace.go:171","msg":"trace[1981390272] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:29; }","duration":"461.268174ms","start":"2026-05-11T10:44:11.972056Z","end":"2026-05-11T10:44:12.433324Z","steps":["trace[1981390272] 'agreement among raft nodes before linearized reading' (duration: 459.171784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.433416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972045Z","time spent":"461.350531ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-05-11T10:44:12.431409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.75511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.433498Z","caller":"traceutil/trace.go:171","msg":"trace[931196517] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:29; }","duration":"409.881553ms","start":"2026-05-11T10:44:12.023601Z","end":"2026-05-11T10:44:12.433483Z","steps":["trace[931196517] 'agreement among raft nodes before linearized reading' (duration: 407.7442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.43374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.023575Z","time spent":"409.957459ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-11T10:44:12.431411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.291943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.433968Z","caller":"traceutil/trace.go:171","msg":"trace[1360587971] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:29; }","duration":"461.887332ms","start":"2026-05-11T10:44:11.972063Z","end":"2026-05-11T10:44:12.433951Z","steps":["trace[1360587971] 'agreement among raft nodes before linearized reading' (duration: 459.280692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.434025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972046Z","time spent":"461.962957ms","remote":"127.0.0.1:53894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-05-11T10:44:12.43147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.319406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.434336Z","caller":"traceutil/trace.go:171","msg":"trace[971809719] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"462.164123ms","start":"2026-05-11T10:44:11.972131Z","end":"2026-05-11T10:44:12.434295Z","steps":["trace[971809719] 'agreement among raft nodes before linearized reading' (duration: 459.314675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.434409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972122Z","time spent":"462.26108ms","remote":"127.0.0.1:53674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":26,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-05-11T10:44:12.431509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.38372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.434555Z","caller":"traceutil/trace.go:171","msg":"trace[1461407421] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:29; }","duration":"462.427923ms","start":"2026-05-11T10:44:11.972104Z","end":"2026-05-11T10:44:12.434532Z","steps":["trace[1461407421] 'agreement among raft nodes before linearized reading' (duration: 459.37508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.434605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:11.972098Z","time spent":"462.493288ms","remote":"127.0.0.1:53702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-05-11T10:44:12.804457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.049103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:12.804629Z","caller":"traceutil/trace.go:171","msg":"trace[2125854438] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"368.208102ms","start":"2026-05-11T10:44:12.436387Z","end":"2026-05-11T10:44:12.804596Z","steps":["trace[2125854438] 'process raft request' (duration: 166.971865ms)","trace[2125854438] 'compare' (duration: 200.88238ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:12.805274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.436381Z","time spent":"368.334832ms","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.805293Z","caller":"traceutil/trace.go:171","msg":"trace[1001707352] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"367.502099ms","start":"2026-05-11T10:44:12.437196Z","end":"2026-05-11T10:44:12.804698Z","steps":["trace[1001707352] 'process raft request' (duration: 367.38694ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:12.805337Z","caller":"traceutil/trace.go:171","msg":"trace[1172597861] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"368.881445ms","start":"2026-05-11T10:44:12.436433Z","end":"2026-05-11T10:44:12.805314Z","steps":["trace[1172597861] 'process raft request' (duration: 368.108545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.805404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.437174Z","time spent":"368.17434ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.80544Z","caller":"traceutil/trace.go:171","msg":"trace[1110925728] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"368.077183ms","start":"2026-05-11T10:44:12.437242Z","end":"2026-05-11T10:44:12.805319Z","steps":["trace[1110925728] 'process raft request' (duration: 367.367458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.805461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.436212Z","time spent":"369.194779ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.805535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.437232Z","time spent":"368.258607ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.805263Z","caller":"traceutil/trace.go:171","msg":"trace[1936421929] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"367.445275ms","start":"2026-05-11T10:44:12.437795Z","end":"2026-05-11T10:44:12.80524Z","steps":["trace[1936421929] 'process raft request' (duration: 367.329056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.806092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.437781Z","time spent":"368.007418ms","remote":"127.0.0.1:53674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.806209Z","caller":"traceutil/trace.go:171","msg":"trace[918328545] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"368.713142ms","start":"2026-05-11T10:44:12.437404Z","end":"2026-05-11T10:44:12.806117Z","steps":["trace[918328545] 'process raft request' (duration: 367.26281ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:12.806237Z","caller":"traceutil/trace.go:171","msg":"trace[1125131722] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"368.543259ms","start":"2026-05-11T10:44:12.437298Z","end":"2026-05-11T10:44:12.805841Z","steps":["trace[1125131722] 'process raft request' (duration: 367.344166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.806288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.437393Z","time spent":"368.865373ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.80636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.437275Z","time spent":"369.024096ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:12.807026Z","caller":"traceutil/trace.go:171","msg":"trace[975592] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:33; }","duration":"368.477002ms","start":"2026-05-11T10:44:12.438496Z","end":"2026-05-11T10:44:12.806973Z","steps":["trace[975592] 'read index received' (duration: 16.46149ms)","trace[975592] 'applied index is now lower than readState.Index' (duration: 352.014182ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:12.806998Z","caller":"traceutil/trace.go:171","msg":"trace[290141722] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"368.385595ms","start":"2026-05-11T10:44:12.438581Z","end":"2026-05-11T10:44:12.806967Z","steps":["trace[290141722] 'process raft request' (duration: 366.6106ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:12.807112Z","caller":"traceutil/trace.go:171","msg":"trace[1164222468] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"368.3258ms","start":"2026-05-11T10:44:12.438758Z","end":"2026-05-11T10:44:12.807083Z","steps":["trace[1164222468] 'process raft request' (duration: 368.153147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.807203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.438747Z","time spent":"368.415987ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.807222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.438576Z","time spent":"368.504034ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:12.808936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.047142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.809001Z","caller":"traceutil/trace.go:171","msg":"trace[1879323697] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:39; }","duration":"318.14836ms","start":"2026-05-11T10:44:12.490836Z","end":"2026-05-11T10:44:12.808984Z","steps":["trace[1879323697] 'agreement among raft nodes before linearized reading' (duration: 316.951829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.809035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.490816Z","time spent":"318.210084ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-11T10:44:12.810053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.546397ms","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-11T10:44:12.810101Z","caller":"traceutil/trace.go:171","msg":"trace[2130759035] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:39; }","duration":"371.611552ms","start":"2026-05-11T10:44:12.438474Z","end":"2026-05-11T10:44:12.810085Z","steps":["trace[2130759035] 'agreement among raft nodes before linearized reading' (duration: 368.683198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.810126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.438465Z","time spent":"371.654946ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"warn","ts":"2026-05-11T10:44:12.812634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.194323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:12.812689Z","caller":"traceutil/trace.go:171","msg":"trace[60843440] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:39; }","duration":"353.330253ms","start":"2026-05-11T10:44:12.459345Z","end":"2026-05-11T10:44:12.812675Z","steps":["trace[60843440] 'agreement among raft nodes before linearized reading' (duration: 347.888967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:12.812823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.459313Z","time spent":"353.498586ms","remote":"127.0.0.1:53646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"warn","ts":"2026-05-11T10:44:13.331606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.03317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:13.331925Z","caller":"traceutil/trace.go:171","msg":"trace[924226157] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"519.173666ms","start":"2026-05-11T10:44:12.812695Z","end":"2026-05-11T10:44:13.331868Z","steps":["trace[924226157] 'process raft request' (duration: 155.801659ms)","trace[924226157] 'compare' (duration: 362.858377ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:13.331954Z","caller":"traceutil/trace.go:171","msg":"trace[1761386125] linearizableReadLoop","detail":"{readStateIndex:46; appliedIndex:43; }","duration":"517.963184ms","start":"2026-05-11T10:44:12.813974Z","end":"2026-05-11T10:44:13.331937Z","steps":["trace[1761386125] 'read index received' (duration: 154.605148ms)","trace[1761386125] 'applied index is now lower than readState.Index' (duration: 363.356956ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:13.332037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.81268Z","time spent":"519.313067ms","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:13.332097Z","caller":"traceutil/trace.go:171","msg":"trace[1130853020] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"518.287548ms","start":"2026-05-11T10:44:12.813775Z","end":"2026-05-11T10:44:13.332063Z","steps":["trace[1130853020] 'process raft request' (duration: 518.062671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.332279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.813769Z","time spent":"518.421378ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":350,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:13.332318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.325961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:13.33229Z","caller":"traceutil/trace.go:171","msg":"trace[1542713732] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"519.3521ms","start":"2026-05-11T10:44:12.812856Z","end":"2026-05-11T10:44:13.332209Z","steps":["trace[1542713732] 'process raft request' (duration: 518.921348ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:13.332377Z","caller":"traceutil/trace.go:171","msg":"trace[1662677401] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:42; }","duration":"518.397227ms","start":"2026-05-11T10:44:12.81396Z","end":"2026-05-11T10:44:13.332358Z","steps":["trace[1662677401] 'agreement among raft nodes before linearized reading' (duration: 518.199242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.332399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.710575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:13.332424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.813956Z","time spent":"518.455271ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"info","ts":"2026-05-11T10:44:13.332457Z","caller":"traceutil/trace.go:171","msg":"trace[1121765795] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:42; }","duration":"467.810403ms","start":"2026-05-11T10:44:12.86463Z","end":"2026-05-11T10:44:13.33244Z","steps":["trace[1121765795] 'agreement among raft nodes before linearized reading' (duration: 467.706605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.332495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.86461Z","time spent":"467.877638ms","remote":"127.0.0.1:53676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-11T10:44:13.33249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.812823Z","time spent":"519.573307ms","remote":"127.0.0.1:54094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:13.332564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.533373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:13.332651Z","caller":"traceutil/trace.go:171","msg":"trace[2031452147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:42; }","duration":"461.676574ms","start":"2026-05-11T10:44:12.870949Z","end":"2026-05-11T10:44:13.332625Z","steps":["trace[2031452147] 'agreement among raft nodes before linearized reading' (duration: 461.519182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.332696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:12.870938Z","time spent":"461.75049ms","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-11T10:44:13.621968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.376192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:13.622167Z","caller":"traceutil/trace.go:171","msg":"trace[2049370740] linearizableReadLoop","detail":"{readStateIndex:47; appliedIndex:46; }","duration":"283.844463ms","start":"2026-05-11T10:44:13.338302Z","end":"2026-05-11T10:44:13.622146Z","steps":["trace[2049370740] 'read index received' (duration: 131.158937ms)","trace[2049370740] 'applied index is now lower than readState.Index' (duration: 152.684166ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:13.622361Z","caller":"traceutil/trace.go:171","msg":"trace[1030362814] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"285.445946ms","start":"2026-05-11T10:44:13.336903Z","end":"2026-05-11T10:44:13.622349Z","steps":["trace[1030362814] 'process raft request' (duration: 132.632ms)","trace[1030362814] 'compare' (duration: 152.222791ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:13.622683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.379574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:13.622777Z","caller":"traceutil/trace.go:171","msg":"trace[1576464536] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:43; }","duration":"284.512924ms","start":"2026-05-11T10:44:13.338251Z","end":"2026-05-11T10:44:13.622764Z","steps":["trace[1576464536] 'agreement among raft nodes before linearized reading' (duration: 284.355462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.622945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.07536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:13.623048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.535339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:13.62313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.055039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:13.623202Z","caller":"traceutil/trace.go:171","msg":"trace[624628210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:43; }","duration":"251.181158ms","start":"2026-05-11T10:44:13.372008Z","end":"2026-05-11T10:44:13.623189Z","steps":["trace[624628210] 'agreement among raft nodes before linearized reading' (duration: 251.090411ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:13.623135Z","caller":"traceutil/trace.go:171","msg":"trace[1358175710] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:43; }","duration":"235.684411ms","start":"2026-05-11T10:44:13.38743Z","end":"2026-05-11T10:44:13.623114Z","steps":["trace[1358175710] 'agreement among raft nodes before linearized reading' (duration: 235.513248ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:13.623064Z","caller":"traceutil/trace.go:171","msg":"trace[1373141711] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:43; }","duration":"284.249034ms","start":"2026-05-11T10:44:13.33877Z","end":"2026-05-11T10:44:13.623019Z","steps":["trace[1373141711] 'agreement among raft nodes before linearized reading' (duration: 284.050028ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:13.986281Z","caller":"traceutil/trace.go:171","msg":"trace[1631794970] linearizableReadLoop","detail":"{readStateIndex:49; appliedIndex:48; }","duration":"339.09926ms","start":"2026-05-11T10:44:13.64716Z","end":"2026-05-11T10:44:13.986259Z","steps":["trace[1631794970] 'read index received' (duration: 271.620386ms)","trace[1631794970] 'applied index is now lower than readState.Index' (duration: 67.478003ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:13.986409Z","caller":"traceutil/trace.go:171","msg":"trace[2038600739] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"359.147966ms","start":"2026-05-11T10:44:13.627214Z","end":"2026-05-11T10:44:13.986362Z","steps":["trace[2038600739] 'process raft request' (duration: 291.590277ms)","trace[2038600739] 'compare' (duration: 67.311961ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:13.986479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.656852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:13.986499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.0346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:13.986535Z","caller":"traceutil/trace.go:171","msg":"trace[402873689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:45; }","duration":"115.088784ms","start":"2026-05-11T10:44:13.871439Z","end":"2026-05-11T10:44:13.986528Z","steps":["trace[402873689] 'agreement among raft nodes before linearized reading' (duration: 115.042561ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:13.986541Z","caller":"traceutil/trace.go:171","msg":"trace[905515104] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:0; response_revision:45; }","duration":"336.75895ms","start":"2026-05-11T10:44:13.649766Z","end":"2026-05-11T10:44:13.986525Z","steps":["trace[905515104] 'agreement among raft nodes before linearized reading' (duration: 336.657262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.986546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:13.6272Z","time spent":"359.283577ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":647,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:13.986573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:13.64975Z","time spent":"336.817934ms","remote":"127.0.0.1:53894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/system:discovery\" "} {"level":"warn","ts":"2026-05-11T10:44:13.986454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.15547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d47158e1\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:13.986891Z","caller":"traceutil/trace.go:171","msg":"trace[806740861] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d47158e1; range_end:; response_count:0; response_revision:45; }","duration":"358.632157ms","start":"2026-05-11T10:44:13.628237Z","end":"2026-05-11T10:44:13.98687Z","steps":["trace[806740861] 'agreement among raft nodes before linearized reading' (duration: 358.132689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:13.987021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:13.628225Z","time spent":"358.773177ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/events/default/instance.18ae7ce6d47158e1\" "} {"level":"warn","ts":"2026-05-11T10:44:13.986735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.504769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5889"} {"level":"info","ts":"2026-05-11T10:44:13.987468Z","caller":"traceutil/trace.go:171","msg":"trace[1095445234] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:45; }","duration":"142.259887ms","start":"2026-05-11T10:44:13.845191Z","end":"2026-05-11T10:44:13.987451Z","steps":["trace[1095445234] 'agreement among raft nodes before linearized reading' (duration: 141.510209ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:14.18903Z","caller":"traceutil/trace.go:171","msg":"trace[1803078561] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"196.257877ms","start":"2026-05-11T10:44:13.992732Z","end":"2026-05-11T10:44:14.18899Z","steps":["trace[1803078561] 'process raft request' (duration: 195.933601ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:14.189119Z","caller":"traceutil/trace.go:171","msg":"trace[1353330813] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"195.574774ms","start":"2026-05-11T10:44:13.993497Z","end":"2026-05-11T10:44:14.189072Z","steps":["trace[1353330813] 'process raft request' (duration: 195.399711ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:14.189286Z","caller":"traceutil/trace.go:171","msg":"trace[1081667154] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"195.499439ms","start":"2026-05-11T10:44:13.993764Z","end":"2026-05-11T10:44:14.189264Z","steps":["trace[1081667154] 'process raft request' (duration: 195.181885ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:14.189701Z","caller":"traceutil/trace.go:171","msg":"trace[1636905692] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"178.991193ms","start":"2026-05-11T10:44:14.010698Z","end":"2026-05-11T10:44:14.189689Z","steps":["trace[1636905692] 'process raft request' (duration: 178.451081ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:14.569626Z","caller":"traceutil/trace.go:171","msg":"trace[684419210] linearizableReadLoop","detail":"{readStateIndex:56; appliedIndex:54; }","duration":"377.188957ms","start":"2026-05-11T10:44:14.192402Z","end":"2026-05-11T10:44:14.569591Z","steps":["trace[684419210] 'read index received' (duration: 307.095156ms)","trace[684419210] 'applied index is now lower than readState.Index' (duration: 70.092821ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:14.569734Z","caller":"traceutil/trace.go:171","msg":"trace[1155717577] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"402.586437ms","start":"2026-05-11T10:44:14.167136Z","end":"2026-05-11T10:44:14.569722Z","steps":["trace[1155717577] 'process raft request' (duration: 402.404363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:14.569836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.167119Z","time spent":"402.650083ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:14.569907Z","caller":"traceutil/trace.go:171","msg":"trace[1079431062] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"417.413577ms","start":"2026-05-11T10:44:14.152458Z","end":"2026-05-11T10:44:14.569872Z","steps":["trace[1079431062] 'process raft request' (duration: 346.942096ms)","trace[1079431062] 'compare' (duration: 69.984462ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:14.570045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.152437Z","time spent":"417.540396ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:14.570187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.775254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:14.570228Z","caller":"traceutil/trace.go:171","msg":"trace[2010184248] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:51; }","duration":"377.847949ms","start":"2026-05-11T10:44:14.192369Z","end":"2026-05-11T10:44:14.570217Z","steps":["trace[2010184248] 'agreement among raft nodes before linearized reading' (duration: 377.707728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:14.570263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.192355Z","time spent":"377.902213ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:discovery\" "} {"level":"info","ts":"2026-05-11T10:44:14.582675Z","caller":"traceutil/trace.go:171","msg":"trace[1674199638] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"389.07148ms","start":"2026-05-11T10:44:14.193569Z","end":"2026-05-11T10:44:14.582641Z","steps":["trace[1674199638] 'process raft request' (duration: 388.847473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:14.582864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.193549Z","time spent":"389.219572ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:14.582928Z","caller":"traceutil/trace.go:171","msg":"trace[653612361] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"389.3291ms","start":"2026-05-11T10:44:14.193551Z","end":"2026-05-11T10:44:14.58288Z","steps":["trace[653612361] 'process raft request' (duration: 389.042128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:14.583055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.193523Z","time spent":"389.473121ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":632,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:14.583054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.431175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:14.583119Z","caller":"traceutil/trace.go:171","msg":"trace[1206556971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:53; }","duration":"111.532983ms","start":"2026-05-11T10:44:14.471568Z","end":"2026-05-11T10:44:14.583101Z","steps":["trace[1206556971] 'agreement among raft nodes before linearized reading' (duration: 111.372521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.102218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.769622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:15.102499Z","caller":"traceutil/trace.go:171","msg":"trace[1872302409] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"478.234876ms","start":"2026-05-11T10:44:14.624242Z","end":"2026-05-11T10:44:15.102477Z","steps":["trace[1872302409] 'process raft request' (duration: 478.191982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.102595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.624225Z","time spent":"478.331493ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:15.102825Z","caller":"traceutil/trace.go:171","msg":"trace[1946815069] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"515.365726ms","start":"2026-05-11T10:44:14.587443Z","end":"2026-05-11T10:44:15.102808Z","steps":["trace[1946815069] 'process raft request' (duration: 514.89357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.102925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.587431Z","time spent":"515.440252ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1059,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:15.102907Z","caller":"traceutil/trace.go:171","msg":"trace[923241024] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"516.876073ms","start":"2026-05-11T10:44:14.585993Z","end":"2026-05-11T10:44:15.102869Z","steps":["trace[923241024] 'process raft request' (duration: 234.375345ms)","trace[923241024] 'compare' (duration: 281.608628ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:15.102983Z","caller":"traceutil/trace.go:171","msg":"trace[1909857361] linearizableReadLoop","detail":"{readStateIndex:61; appliedIndex:59; }","duration":"478.707402ms","start":"2026-05-11T10:44:14.624253Z","end":"2026-05-11T10:44:15.10296Z","steps":["trace[1909857361] 'read index received' (duration: 196.124087ms)","trace[1909857361] 'applied index is now lower than readState.Index' (duration: 282.580685ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:15.103091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.585973Z","time spent":"517.019833ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":796,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:15.103127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.859993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:15.103167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.590172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:15.103185Z","caller":"traceutil/trace.go:171","msg":"trace[1659366801] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:0; response_revision:57; }","duration":"478.95057ms","start":"2026-05-11T10:44:14.624219Z","end":"2026-05-11T10:44:15.10317Z","steps":["trace[1659366801] 'agreement among raft nodes before linearized reading' (duration: 478.861643ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:15.103222Z","caller":"traceutil/trace.go:171","msg":"trace[1324618292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:57; }","duration":"131.682129ms","start":"2026-05-11T10:44:14.971525Z","end":"2026-05-11T10:44:15.103207Z","steps":["trace[1324618292] 'agreement among raft nodes before linearized reading' (duration: 131.597112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.103228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:14.624205Z","time spent":"479.012794ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:monitoring\" "} {"level":"warn","ts":"2026-05-11T10:44:15.594827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.103804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:15.59511Z","caller":"traceutil/trace.go:171","msg":"trace[1421371368] linearizableReadLoop","detail":"{readStateIndex:65; appliedIndex:62; }","duration":"486.979434ms","start":"2026-05-11T10:44:15.108109Z","end":"2026-05-11T10:44:15.595089Z","steps":["trace[1421371368] 'read index received' (duration: 47.289405ms)","trace[1421371368] 'applied index is now lower than readState.Index' (duration: 439.688799ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:15.595215Z","caller":"traceutil/trace.go:171","msg":"trace[2054682263] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"488.064259ms","start":"2026-05-11T10:44:15.107141Z","end":"2026-05-11T10:44:15.595205Z","steps":["trace[2054682263] 'process raft request' (duration: 487.797377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.595289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.107129Z","time spent":"488.115133ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1216,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:15.595471Z","caller":"traceutil/trace.go:171","msg":"trace[1381258699] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"436.646186ms","start":"2026-05-11T10:44:15.158797Z","end":"2026-05-11T10:44:15.595443Z","steps":["trace[1381258699] 'process raft request' (duration: 436.255435ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:15.595516Z","caller":"traceutil/trace.go:171","msg":"trace[1067322372] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"488.940636ms","start":"2026-05-11T10:44:15.106544Z","end":"2026-05-11T10:44:15.595484Z","steps":["trace[1067322372] 'process raft request' (duration: 230.282052ms)","trace[1067322372] 'compare' (duration: 256.960803ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:15.595618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.158782Z","time spent":"436.776416ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:15.595644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.106517Z","time spent":"489.066626ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":621,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:15.595626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.509305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d4719910\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:15.595775Z","caller":"traceutil/trace.go:171","msg":"trace[1845742307] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d4719910; range_end:; response_count:0; response_revision:61; }","duration":"487.69691ms","start":"2026-05-11T10:44:15.108057Z","end":"2026-05-11T10:44:15.595754Z","steps":["trace[1845742307] 'agreement among raft nodes before linearized reading' (duration: 487.392647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.595951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.850611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:15.596099Z","caller":"traceutil/trace.go:171","msg":"trace[1832996656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:61; }","duration":"124.061816ms","start":"2026-05-11T10:44:15.471934Z","end":"2026-05-11T10:44:15.595996Z","steps":["trace[1832996656] 'agreement among raft nodes before linearized reading' (duration: 123.576059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.595965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.108037Z","time spent":"487.909387ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":26,"request content":"key:\"/registry/events/default/instance.18ae7ce6d4719910\" "} {"level":"warn","ts":"2026-05-11T10:44:15.849687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.128718ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:15.849805Z","caller":"traceutil/trace.go:171","msg":"trace[175893324] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"250.55261ms","start":"2026-05-11T10:44:15.599232Z","end":"2026-05-11T10:44:15.849785Z","steps":["trace[175893324] 'process raft request' (duration: 106.211275ms)","trace[175893324] 'compare' (duration: 143.902392ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:15.897272Z","caller":"traceutil/trace.go:171","msg":"trace[1703130630] linearizableReadLoop","detail":"{readStateIndex:69; appliedIndex:66; }","duration":"295.983902ms","start":"2026-05-11T10:44:15.601259Z","end":"2026-05-11T10:44:15.897243Z","steps":["trace[1703130630] 'read index received' (duration: 104.265705ms)","trace[1703130630] 'applied index is now lower than readState.Index' (duration: 191.717537ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:15.897349Z","caller":"traceutil/trace.go:171","msg":"trace[1477528349] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"296.974289ms","start":"2026-05-11T10:44:15.600366Z","end":"2026-05-11T10:44:15.89734Z","steps":["trace[1477528349] 'process raft request' (duration: 296.777804ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:15.897401Z","caller":"traceutil/trace.go:171","msg":"trace[386474190] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"288.357747ms","start":"2026-05-11T10:44:15.60903Z","end":"2026-05-11T10:44:15.897388Z","steps":["trace[386474190] 'process raft request' (duration: 288.167992ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:15.89729Z","caller":"traceutil/trace.go:171","msg":"trace[1116094855] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"297.709395ms","start":"2026-05-11T10:44:15.599556Z","end":"2026-05-11T10:44:15.897265Z","steps":["trace[1116094855] 'process raft request' (duration: 297.463096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:15.89765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.34789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/system-leader-election\" ","response":"range_response_count:1 size:1228"} {"level":"info","ts":"2026-05-11T10:44:15.897722Z","caller":"traceutil/trace.go:171","msg":"trace[1000814534] range","detail":"{range_begin:/registry/flowschemas/system-leader-election; range_end:; response_count:1; response_revision:65; }","duration":"296.47723ms","start":"2026-05-11T10:44:15.601228Z","end":"2026-05-11T10:44:15.897705Z","steps":["trace[1000814534] 'agreement among raft nodes before linearized reading' (duration: 296.292216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.309732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.126775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:16.310185Z","caller":"traceutil/trace.go:171","msg":"trace[1064440155] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"456.574947ms","start":"2026-05-11T10:44:15.853584Z","end":"2026-05-11T10:44:16.310159Z","steps":["trace[1064440155] 'process raft request' (duration: 282.951654ms)","trace[1064440155] 'compare' (duration: 172.93843ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:16.310229Z","caller":"traceutil/trace.go:171","msg":"trace[1604050907] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"407.543978ms","start":"2026-05-11T10:44:15.902647Z","end":"2026-05-11T10:44:16.310191Z","steps":["trace[1604050907] 'process raft request' (duration: 407.201722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.310298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.853562Z","time spent":"456.679705ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:16.310331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.902633Z","time spent":"407.639126ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1199,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:16.310357Z","caller":"traceutil/trace.go:171","msg":"trace[2043261269] linearizableReadLoop","detail":"{readStateIndex:71; appliedIndex:70; }","duration":"412.990637ms","start":"2026-05-11T10:44:15.897351Z","end":"2026-05-11T10:44:16.310342Z","steps":["trace[2043261269] 'read index received' (duration: 239.19167ms)","trace[2043261269] 'applied index is now lower than readState.Index' (duration: 173.797217ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:16.310446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.249459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5510"} {"level":"info","ts":"2026-05-11T10:44:16.310533Z","caller":"traceutil/trace.go:171","msg":"trace[1080604174] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:67; }","duration":"697.369358ms","start":"2026-05-11T10:44:15.613155Z","end":"2026-05-11T10:44:16.310524Z","steps":["trace[1080604174] 'agreement among raft nodes before linearized reading' (duration: 697.226157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.310592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.613138Z","time spent":"697.444373ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5532,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-05-11T10:44:16.310663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.435066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:16.310691Z","caller":"traceutil/trace.go:171","msg":"trace[1623107129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:67; }","duration":"338.501721ms","start":"2026-05-11T10:44:15.972182Z","end":"2026-05-11T10:44:16.310683Z","steps":["trace[1623107129] 'agreement among raft nodes before linearized reading' (duration: 338.456738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.310711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.972157Z","time spent":"338.549775ms","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-11T10:44:16.310798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.500628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d47158e1\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-05-11T10:44:16.31091Z","caller":"traceutil/trace.go:171","msg":"trace[1158670167] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d47158e1; range_end:; response_count:1; response_revision:67; }","duration":"409.6549ms","start":"2026-05-11T10:44:15.901202Z","end":"2026-05-11T10:44:16.310856Z","steps":["trace[1158670167] 'agreement among raft nodes before linearized reading' (duration: 409.425813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.310833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.124249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:public-info-viewer\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:16.311035Z","caller":"traceutil/trace.go:171","msg":"trace[433291821] range","detail":"{range_begin:/registry/clusterroles/system:public-info-viewer; range_end:; response_count:0; response_revision:67; }","duration":"409.362688ms","start":"2026-05-11T10:44:15.901659Z","end":"2026-05-11T10:44:16.311021Z","steps":["trace[433291821] 'agreement among raft nodes before linearized reading' (duration: 409.019392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.311124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.901642Z","time spent":"409.469946ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:public-info-viewer\" "} {"level":"warn","ts":"2026-05-11T10:44:16.311333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:15.901185Z","time spent":"409.815892ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":676,"request content":"key:\"/registry/events/default/instance.18ae7ce6d47158e1\" "} {"level":"warn","ts":"2026-05-11T10:44:16.770814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.93071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:16.771118Z","caller":"traceutil/trace.go:171","msg":"trace[1286429848] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"455.247189ms","start":"2026-05-11T10:44:16.315797Z","end":"2026-05-11T10:44:16.771045Z","steps":["trace[1286429848] 'process raft request' (duration: 215.996204ms)","trace[1286429848] 'compare' (duration: 238.786739ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:16.771368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.315777Z","time spent":"455.431423ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1244,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:16.771428Z","caller":"traceutil/trace.go:171","msg":"trace[678482695] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"455.491818ms","start":"2026-05-11T10:44:16.315907Z","end":"2026-05-11T10:44:16.771398Z","steps":["trace[678482695] 'process raft request' (duration: 455.016861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.771846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.315899Z","time spent":"455.614037ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":600,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:16.772132Z","caller":"traceutil/trace.go:171","msg":"trace[1789215055] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:73; }","duration":"200.901624ms","start":"2026-05-11T10:44:16.571211Z","end":"2026-05-11T10:44:16.772113Z","steps":["trace[1789215055] 'read index received' (duration: 101.964468ms)","trace[1789215055] 'applied index is now lower than readState.Index' (duration: 98.936206ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:16.772304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.094968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:16.772336Z","caller":"traceutil/trace.go:171","msg":"trace[126567616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"201.158353ms","start":"2026-05-11T10:44:16.57117Z","end":"2026-05-11T10:44:16.772328Z","steps":["trace[126567616] 'agreement among raft nodes before linearized reading' (duration: 201.011762ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:16.772068Z","caller":"traceutil/trace.go:171","msg":"trace[975386639] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"455.11817ms","start":"2026-05-11T10:44:16.316868Z","end":"2026-05-11T10:44:16.771987Z","steps":["trace[975386639] 'process raft request' (duration: 454.333109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.772572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.316846Z","time spent":"455.630899ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:16.772681Z","caller":"traceutil/trace.go:171","msg":"trace[222590029] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"392.267142ms","start":"2026-05-11T10:44:16.380393Z","end":"2026-05-11T10:44:16.77266Z","steps":["trace[222590029] 'process raft request' (duration: 391.674957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.772801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.380369Z","time spent":"392.37513ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:16.772903Z","caller":"traceutil/trace.go:171","msg":"trace[1603333766] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"455.009561ms","start":"2026-05-11T10:44:16.317883Z","end":"2026-05-11T10:44:16.772892Z","steps":["trace[1603333766] 'process raft request' (duration: 453.944269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:16.772969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.317864Z","time spent":"455.072777ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:17.419479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.846539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:17.419751Z","caller":"traceutil/trace.go:171","msg":"trace[1352541307] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"603.443223ms","start":"2026-05-11T10:44:16.816245Z","end":"2026-05-11T10:44:17.419689Z","steps":["trace[1352541307] 'process raft request' (duration: 603.305784ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:17.419906Z","caller":"traceutil/trace.go:171","msg":"trace[1082880365] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"604.137193ms","start":"2026-05-11T10:44:16.815716Z","end":"2026-05-11T10:44:17.419853Z","steps":["trace[1082880365] 'process raft request' (duration: 334.856097ms)","trace[1082880365] 'compare' (duration: 268.689459ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:17.420037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.815688Z","time spent":"604.288143ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:17.420111Z","caller":"traceutil/trace.go:171","msg":"trace[573758396] linearizableReadLoop","detail":"{readStateIndex:85; appliedIndex:80; }","duration":"348.093346ms","start":"2026-05-11T10:44:17.071995Z","end":"2026-05-11T10:44:17.420088Z","steps":["trace[573758396] 'read index received' (duration: 78.64613ms)","trace[573758396] 'applied index is now lower than readState.Index' (duration: 269.446176ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:17.420147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.81623Z","time spent":"603.55627ms","remote":"127.0.0.1:54006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":622,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:17.420346Z","caller":"traceutil/trace.go:171","msg":"trace[1967869470] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"558.295937ms","start":"2026-05-11T10:44:16.862039Z","end":"2026-05-11T10:44:17.420334Z","steps":["trace[1967869470] 'process raft request' (duration: 557.725561ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:17.420368Z","caller":"traceutil/trace.go:171","msg":"trace[96555849] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"553.731786ms","start":"2026-05-11T10:44:16.866621Z","end":"2026-05-11T10:44:17.420353Z","steps":["trace[96555849] 'process raft request' (duration: 553.30959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:17.420448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.866612Z","time spent":"553.79216ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:17.420463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.862007Z","time spent":"558.378683ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:17.420627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.63523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:17.420652Z","caller":"traceutil/trace.go:171","msg":"trace[760389547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:80; }","duration":"348.690873ms","start":"2026-05-11T10:44:17.071952Z","end":"2026-05-11T10:44:17.420643Z","steps":["trace[760389547] 'agreement among raft nodes before linearized reading' (duration: 348.647681ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:17.420457Z","caller":"traceutil/trace.go:171","msg":"trace[635153196] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"553.187132ms","start":"2026-05-11T10:44:16.867263Z","end":"2026-05-11T10:44:17.42045Z","steps":["trace[635153196] 'process raft request' (duration: 552.758705ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:17.420853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:16.867241Z","time spent":"553.563156ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:17.420666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.071861Z","time spent":"348.802002ms","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-11T10:44:17.707616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.058313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:17.707844Z","caller":"traceutil/trace.go:171","msg":"trace[702012322] linearizableReadLoop","detail":"{readStateIndex:87; appliedIndex:85; }","duration":"283.540657ms","start":"2026-05-11T10:44:17.424285Z","end":"2026-05-11T10:44:17.707826Z","steps":["trace[702012322] 'read index received' (duration: 112.257969ms)","trace[702012322] 'applied index is now lower than readState.Index' (duration: 171.281887ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:17.707958Z","caller":"traceutil/trace.go:171","msg":"trace[2051210274] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"283.801043ms","start":"2026-05-11T10:44:17.424147Z","end":"2026-05-11T10:44:17.707948Z","steps":["trace[2051210274] 'process raft request' (duration: 283.569849ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:17.708084Z","caller":"traceutil/trace.go:171","msg":"trace[433237448] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"284.901311ms","start":"2026-05-11T10:44:17.423145Z","end":"2026-05-11T10:44:17.708047Z","steps":["trace[433237448] 'process raft request' (duration: 113.346857ms)","trace[433237448] 'compare' (duration: 170.898062ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:17.708195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.891388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:17.708243Z","caller":"traceutil/trace.go:171","msg":"trace[1067006863] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:83; }","duration":"283.946572ms","start":"2026-05-11T10:44:17.424283Z","end":"2026-05-11T10:44:17.70823Z","steps":["trace[1067006863] 'agreement among raft nodes before linearized reading' (duration: 283.845295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:17.708301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.584478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:17.708336Z","caller":"traceutil/trace.go:171","msg":"trace[423293730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:83; }","duration":"136.657762ms","start":"2026-05-11T10:44:17.571666Z","end":"2026-05-11T10:44:17.708324Z","steps":["trace[423293730] 'agreement among raft nodes before linearized reading' (duration: 136.601538ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:17.708425Z","caller":"traceutil/trace.go:171","msg":"trace[1463170739] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"283.92533ms","start":"2026-05-11T10:44:17.424489Z","end":"2026-05-11T10:44:17.708414Z","steps":["trace[1463170739] 'process raft request' (duration: 283.296531ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:18.102983Z","caller":"traceutil/trace.go:171","msg":"trace[1786596570] linearizableReadLoop","detail":"{readStateIndex:91; appliedIndex:89; }","duration":"340.932494ms","start":"2026-05-11T10:44:17.762009Z","end":"2026-05-11T10:44:18.102942Z","steps":["trace[1786596570] 'read index received' (duration: 272.288359ms)","trace[1786596570] 'applied index is now lower than readState.Index' (duration: 68.643175ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:18.103049Z","caller":"traceutil/trace.go:171","msg":"trace[127193332] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"390.738785ms","start":"2026-05-11T10:44:17.71227Z","end":"2026-05-11T10:44:18.103009Z","steps":["trace[127193332] 'process raft request' (duration: 322.104369ms)","trace[127193332] 'compare' (duration: 68.35222ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:18.103175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.142306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:18.103217Z","caller":"traceutil/trace.go:171","msg":"trace[704210393] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:86; }","duration":"341.254755ms","start":"2026-05-11T10:44:17.761954Z","end":"2026-05-11T10:44:18.103208Z","steps":["trace[704210393] 'agreement among raft nodes before linearized reading' (duration: 341.15729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.103259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.761934Z","time spent":"341.316604ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/view\" "} {"level":"warn","ts":"2026-05-11T10:44:18.103284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.712257Z","time spent":"390.922137ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":581,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:18.103093Z","caller":"traceutil/trace.go:171","msg":"trace[1923821372] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"390.591037ms","start":"2026-05-11T10:44:17.712493Z","end":"2026-05-11T10:44:18.103084Z","steps":["trace[1923821372] 'process raft request' (duration: 390.381037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.104445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.712485Z","time spent":"390.97593ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:18.345698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.179925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"warn","ts":"2026-05-11T10:44:18.345886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.714817ms","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-11T10:44:18.345802Z","caller":"traceutil/trace.go:171","msg":"trace[686499040] linearizableReadLoop","detail":"{readStateIndex:92; appliedIndex:91; }","duration":"242.733841ms","start":"2026-05-11T10:44:18.103052Z","end":"2026-05-11T10:44:18.345786Z","steps":["trace[686499040] 'read index received' (duration: 111.401452ms)","trace[686499040] 'applied index is now lower than readState.Index' (duration: 131.331309ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:18.345965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.812034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:18.345945Z","caller":"traceutil/trace.go:171","msg":"trace[1317424904] transaction","detail":"{read_only:false; response_revision:87; number_of_response:1; }","duration":"583.816496ms","start":"2026-05-11T10:44:17.762028Z","end":"2026-05-11T10:44:18.345844Z","steps":["trace[1317424904] 'process raft request' (duration: 452.412721ms)","trace[1317424904] 'compare' (duration: 131.074871ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:18.345995Z","caller":"traceutil/trace.go:171","msg":"trace[1757942489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:87; }","duration":"455.883106ms","start":"2026-05-11T10:44:17.890107Z","end":"2026-05-11T10:44:18.34599Z","steps":["trace[1757942489] 'agreement among raft nodes before linearized reading' (duration: 455.844678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.346131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.761996Z","time spent":"584.038029ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:18.346152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.890088Z","time spent":"456.012201ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T10:44:18.345928Z","caller":"traceutil/trace.go:171","msg":"trace[1843986909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:87; }","duration":"455.811799ms","start":"2026-05-11T10:44:17.890106Z","end":"2026-05-11T10:44:18.345918Z","steps":["trace[1843986909] 'agreement among raft nodes before linearized reading' (duration: 455.718424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.346517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:17.890088Z","time spent":"456.419583ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T10:44:18.568713Z","caller":"traceutil/trace.go:171","msg":"trace[1042455299] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"458.078171ms","start":"2026-05-11T10:44:18.110608Z","end":"2026-05-11T10:44:18.568686Z","steps":["trace[1042455299] 'process raft request' (duration: 384.120524ms)","trace[1042455299] 'compare' (duration: 73.735338ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:18.568759Z","caller":"traceutil/trace.go:171","msg":"trace[1280207463] linearizableReadLoop","detail":"{readStateIndex:95; appliedIndex:92; }","duration":"222.75516ms","start":"2026-05-11T10:44:18.345984Z","end":"2026-05-11T10:44:18.568739Z","steps":["trace[1280207463] 'read index received' (duration: 148.877419ms)","trace[1280207463] 'applied index is now lower than readState.Index' (duration: 73.876681ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:18.568814Z","caller":"traceutil/trace.go:171","msg":"trace[872882534] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"457.951147ms","start":"2026-05-11T10:44:18.110851Z","end":"2026-05-11T10:44:18.568802Z","steps":["trace[872882534] 'process raft request' (duration: 457.780356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.568823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.110581Z","time spent":"458.190536ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:18.568852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.11084Z","time spent":"457.994865ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:18.568893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.173231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:18.568849Z","caller":"traceutil/trace.go:171","msg":"trace[1612389526] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"457.455671ms","start":"2026-05-11T10:44:18.111381Z","end":"2026-05-11T10:44:18.568836Z","steps":["trace[1612389526] 'process raft request' (duration: 457.299168ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:18.568954Z","caller":"traceutil/trace.go:171","msg":"trace[649057726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:90; }","duration":"397.274457ms","start":"2026-05-11T10:44:18.171665Z","end":"2026-05-11T10:44:18.56894Z","steps":["trace[649057726] 'agreement among raft nodes before linearized reading' (duration: 397.177711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.569071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.171647Z","time spent":"397.344813ms","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-11T10:44:18.569085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.111373Z","time spent":"457.581204ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1121,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:18.573302Z","caller":"traceutil/trace.go:171","msg":"trace[1070697875] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"221.363017ms","start":"2026-05-11T10:44:18.351925Z","end":"2026-05-11T10:44:18.573288Z","steps":["trace[1070697875] 'process raft request' (duration: 221.149267ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:18.573468Z","caller":"traceutil/trace.go:171","msg":"trace[1943387892] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"221.491241ms","start":"2026-05-11T10:44:18.351967Z","end":"2026-05-11T10:44:18.573458Z","steps":["trace[1943387892] 'process raft request' (duration: 221.164396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.573626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.876755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d4718555\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-11T10:44:18.573665Z","caller":"traceutil/trace.go:171","msg":"trace[1503372631] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d4718555; range_end:; response_count:1; response_revision:92; }","duration":"223.947532ms","start":"2026-05-11T10:44:18.349708Z","end":"2026-05-11T10:44:18.573656Z","steps":["trace[1503372631] 'agreement among raft nodes before linearized reading' (duration: 223.857697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.990022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.889589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:18.990409Z","caller":"traceutil/trace.go:171","msg":"trace[1136284901] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"378.847958ms","start":"2026-05-11T10:44:18.611539Z","end":"2026-05-11T10:44:18.990387Z","steps":["trace[1136284901] 'process raft request' (duration: 378.735713ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:18.990398Z","caller":"traceutil/trace.go:171","msg":"trace[1052572989] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"413.07755ms","start":"2026-05-11T10:44:18.577282Z","end":"2026-05-11T10:44:18.99036Z","steps":["trace[1052572989] 'process raft request' (duration: 412.86895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.99054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.611514Z","time spent":"378.944293ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1101,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:18.990475Z","caller":"traceutil/trace.go:171","msg":"trace[951914466] transaction","detail":"{read_only:false; response_revision:94; number_of_response:1; }","duration":"414.470301ms","start":"2026-05-11T10:44:18.575985Z","end":"2026-05-11T10:44:18.990456Z","steps":["trace[951914466] 'process raft request' (duration: 289.055627ms)","trace[951914466] 'compare' (duration: 124.767646ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:18.990604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.577254Z","time spent":"413.225732ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":827,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:18.990681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.575967Z","time spent":"414.631305ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:18.990842Z","caller":"traceutil/trace.go:171","msg":"trace[607169805] linearizableReadLoop","detail":"{readStateIndex:99; appliedIndex:97; }","duration":"413.936509ms","start":"2026-05-11T10:44:18.576893Z","end":"2026-05-11T10:44:18.990829Z","steps":["trace[607169805] 'read index received' (duration: 29.9594ms)","trace[607169805] 'applied index is now lower than readState.Index' (duration: 383.975509ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:18.99099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.095391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-11T10:44:18.991035Z","caller":"traceutil/trace.go:171","msg":"trace[1706156871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:96; }","duration":"414.169728ms","start":"2026-05-11T10:44:18.576849Z","end":"2026-05-11T10:44:18.991018Z","steps":["trace[1706156871] 'agreement among raft nodes before linearized reading' (duration: 414.073922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.99107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.576836Z","time spent":"414.227425ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-11T10:44:18.991138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.667637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:18.991258Z","caller":"traceutil/trace.go:171","msg":"trace[1799987483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:96; }","duration":"320.79983ms","start":"2026-05-11T10:44:18.670411Z","end":"2026-05-11T10:44:18.991211Z","steps":["trace[1799987483] 'agreement among raft nodes before linearized reading' (duration: 320.646998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.991274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.993796ms","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-11T10:44:18.991426Z","caller":"traceutil/trace.go:171","msg":"trace[287734351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:96; }","duration":"414.270863ms","start":"2026-05-11T10:44:18.577139Z","end":"2026-05-11T10:44:18.991409Z","steps":["trace[287734351] 'agreement among raft nodes before linearized reading' (duration: 413.995586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:18.991537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.577119Z","time spent":"414.404486ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-11T10:44:18.991353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.670388Z","time spent":"320.915045ms","remote":"127.0.0.1:53538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-11T10:44:18.99111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.354721ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:18.992085Z","caller":"traceutil/trace.go:171","msg":"trace[1792378038] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:96; }","duration":"391.335973ms","start":"2026-05-11T10:44:18.600733Z","end":"2026-05-11T10:44:18.992069Z","steps":["trace[1792378038] 'agreement among raft nodes before linearized reading' (duration: 390.333882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:19.378955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.539969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:19.379283Z","caller":"traceutil/trace.go:171","msg":"trace[564368243] linearizableReadLoop","detail":"{readStateIndex:107; appliedIndex:102; }","duration":"107.665336ms","start":"2026-05-11T10:44:19.271601Z","end":"2026-05-11T10:44:19.379266Z","steps":["trace[564368243] 'read index received' (duration: 696.137µs)","trace[564368243] 'applied index is now lower than readState.Index' (duration: 106.968089ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:19.379374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.775081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:19.379405Z","caller":"traceutil/trace.go:171","msg":"trace[1898600224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:102; }","duration":"107.857707ms","start":"2026-05-11T10:44:19.271538Z","end":"2026-05-11T10:44:19.379396Z","steps":["trace[1898600224] 'agreement among raft nodes before linearized reading' (duration: 107.785371ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:19.37934Z","caller":"traceutil/trace.go:171","msg":"trace[869125864] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"383.048453ms","start":"2026-05-11T10:44:18.996264Z","end":"2026-05-11T10:44:19.379313Z","steps":["trace[869125864] 'process raft request' (duration: 276.054195ms)","trace[869125864] 'compare' (duration: 106.331629ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:19.379484Z","caller":"traceutil/trace.go:171","msg":"trace[1256148054] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"382.753568ms","start":"2026-05-11T10:44:18.996709Z","end":"2026-05-11T10:44:19.379463Z","steps":["trace[1256148054] 'process raft request' (duration: 382.482531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:19.379597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.996232Z","time spent":"383.272623ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:19.379605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.996695Z","time spent":"382.850843ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:19.379598Z","caller":"traceutil/trace.go:171","msg":"trace[1106288581] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"382.732599ms","start":"2026-05-11T10:44:18.996856Z","end":"2026-05-11T10:44:19.379588Z","steps":["trace[1106288581] 'process raft request' (duration: 382.376726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:19.379774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.996847Z","time spent":"382.891672ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:19.37992Z","caller":"traceutil/trace.go:171","msg":"trace[1860393665] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"383.431886ms","start":"2026-05-11T10:44:18.996476Z","end":"2026-05-11T10:44:19.379908Z","steps":["trace[1860393665] 'process raft request' (duration: 382.632413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:19.379991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.996271Z","time spent":"383.678684ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:19.379788Z","caller":"traceutil/trace.go:171","msg":"trace[1669156534] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"383.284052ms","start":"2026-05-11T10:44:18.996434Z","end":"2026-05-11T10:44:19.379718Z","steps":["trace[1669156534] 'process raft request' (duration: 382.618983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:19.380853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:18.996419Z","time spent":"384.355003ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2012,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:19.761934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.304326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:19.762266Z","caller":"traceutil/trace.go:171","msg":"trace[69809307] linearizableReadLoop","detail":"{readStateIndex:109; appliedIndex:107; }","duration":"355.15123ms","start":"2026-05-11T10:44:19.407091Z","end":"2026-05-11T10:44:19.762242Z","steps":["trace[69809307] 'read index received' (duration: 55.010934ms)","trace[69809307] 'applied index is now lower than readState.Index' (duration: 300.139166ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:19.762345Z","caller":"traceutil/trace.go:171","msg":"trace[708505754] transaction","detail":"{read_only:false; response_revision:105; number_of_response:1; }","duration":"353.501196ms","start":"2026-05-11T10:44:19.408835Z","end":"2026-05-11T10:44:19.762336Z","steps":["trace[708505754] 'process raft request' (duration: 353.319355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:19.762461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:19.408817Z","time spent":"353.581112ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:19.762639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.530242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3971"} {"level":"info","ts":"2026-05-11T10:44:19.762901Z","caller":"traceutil/trace.go:171","msg":"trace[1352671031] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:105; }","duration":"355.825238ms","start":"2026-05-11T10:44:19.407057Z","end":"2026-05-11T10:44:19.762882Z","steps":["trace[1352671031] 'agreement among raft nodes before linearized reading' (duration: 355.425326ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:19.762261Z","caller":"traceutil/trace.go:171","msg":"trace[969114612] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"377.236839ms","start":"2026-05-11T10:44:19.384985Z","end":"2026-05-11T10:44:19.762222Z","steps":["trace[969114612] 'process raft request' (duration: 241.560379ms)","trace[969114612] 'compare' (duration: 135.049159ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:19.763047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:19.384962Z","time spent":"378.05377ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1917,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:19.763133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:19.407044Z","time spent":"355.959472ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":3993,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-05-11T10:44:19.762704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.682037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d4718555\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-11T10:44:19.763238Z","caller":"traceutil/trace.go:171","msg":"trace[149357777] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d4718555; range_end:; response_count:1; response_revision:105; }","duration":"297.27889ms","start":"2026-05-11T10:44:19.465944Z","end":"2026-05-11T10:44:19.763223Z","steps":["trace[149357777] 'agreement among raft nodes before linearized reading' (duration: 296.605731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:20.206111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.849203ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:20.206305Z","caller":"traceutil/trace.go:171","msg":"trace[207374521] linearizableReadLoop","detail":"{readStateIndex:113; appliedIndex:111; }","duration":"419.578919ms","start":"2026-05-11T10:44:19.78671Z","end":"2026-05-11T10:44:20.206289Z","steps":["trace[207374521] 'read index received' (duration: 173.515855ms)","trace[207374521] 'applied index is now lower than readState.Index' (duration: 246.061984ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:20.206398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.689434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d4719910\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-05-11T10:44:20.206428Z","caller":"traceutil/trace.go:171","msg":"trace[1226505418] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d4719910; range_end:; response_count:1; response_revision:108; }","duration":"419.77052ms","start":"2026-05-11T10:44:19.786648Z","end":"2026-05-11T10:44:20.206419Z","steps":["trace[1226505418] 'agreement among raft nodes before linearized reading' (duration: 419.689264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:20.206461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:19.786624Z","time spent":"419.829478ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":670,"request content":"key:\"/registry/events/default/instance.18ae7ce6d4719910\" "} {"level":"info","ts":"2026-05-11T10:44:20.206633Z","caller":"traceutil/trace.go:171","msg":"trace[27286015] transaction","detail":"{read_only:false; response_revision:108; number_of_response:1; }","duration":"436.837004ms","start":"2026-05-11T10:44:19.769779Z","end":"2026-05-11T10:44:20.206616Z","steps":["trace[27286015] 'process raft request' (duration: 436.434911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:20.206711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:19.769762Z","time spent":"436.909281ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:20.206793Z","caller":"traceutil/trace.go:171","msg":"trace[489277174] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"438.999964ms","start":"2026-05-11T10:44:19.767759Z","end":"2026-05-11T10:44:20.206759Z","steps":["trace[489277174] 'process raft request' (duration: 192.443812ms)","trace[489277174] 'compare' (duration: 245.725018ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:20.206932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:19.76775Z","time spent":"439.122879ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:20.556291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.729948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:20.556411Z","caller":"traceutil/trace.go:171","msg":"trace[1795248754] linearizableReadLoop","detail":"{readStateIndex:116; appliedIndex:115; }","duration":"262.57117ms","start":"2026-05-11T10:44:20.293818Z","end":"2026-05-11T10:44:20.556389Z","steps":["trace[1795248754] 'read index received' (duration: 43.657839ms)","trace[1795248754] 'applied index is now lower than readState.Index' (duration: 218.911471ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:20.55652Z","caller":"traceutil/trace.go:171","msg":"trace[844713592] transaction","detail":"{read_only:false; response_revision:111; number_of_response:1; }","duration":"304.765944ms","start":"2026-05-11T10:44:20.251729Z","end":"2026-05-11T10:44:20.556495Z","steps":["trace[844713592] 'process raft request' (duration: 85.71972ms)","trace[844713592] 'compare' (duration: 218.550096ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:20.556569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.742102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-problem-detector\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:20.556611Z","caller":"traceutil/trace.go:171","msg":"trace[1396830085] range","detail":"{range_begin:/registry/clusterroles/system:node-problem-detector; range_end:; response_count:0; response_revision:111; }","duration":"262.819709ms","start":"2026-05-11T10:44:20.293778Z","end":"2026-05-11T10:44:20.556598Z","steps":["trace[1396830085] 'agreement among raft nodes before linearized reading' (duration: 262.715823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:20.556666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.602153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:20.556692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:20.251706Z","time spent":"304.875689ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:20.556741Z","caller":"traceutil/trace.go:171","msg":"trace[1118412797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:111; }","duration":"202.715258ms","start":"2026-05-11T10:44:20.35401Z","end":"2026-05-11T10:44:20.556725Z","steps":["trace[1118412797] 'agreement among raft nodes before linearized reading' (duration: 202.599713ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:20.743833Z","caller":"traceutil/trace.go:171","msg":"trace[2126677920] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"183.460332ms","start":"2026-05-11T10:44:20.560353Z","end":"2026-05-11T10:44:20.743814Z","steps":["trace[2126677920] 'process raft request' (duration: 172.869898ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:20.769586Z","caller":"traceutil/trace.go:171","msg":"trace[1059812762] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"208.161664ms","start":"2026-05-11T10:44:20.561395Z","end":"2026-05-11T10:44:20.769556Z","steps":["trace[1059812762] 'process raft request' (duration: 207.998871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:21.048165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.55304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:21.048262Z","caller":"traceutil/trace.go:171","msg":"trace[477575652] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"211.24756ms","start":"2026-05-11T10:44:20.836994Z","end":"2026-05-11T10:44:21.048241Z","steps":["trace[477575652] 'process raft request' (duration: 22.555377ms)","trace[477575652] 'compare' (duration: 188.451954ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:21.114577Z","caller":"traceutil/trace.go:171","msg":"trace[29980989] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"275.859495ms","start":"2026-05-11T10:44:20.838703Z","end":"2026-05-11T10:44:21.114562Z","steps":["trace[29980989] 'process raft request' (duration: 275.73234ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:21.114564Z","caller":"traceutil/trace.go:171","msg":"trace[722618664] linearizableReadLoop","detail":"{readStateIndex:122; appliedIndex:121; }","duration":"116.301299ms","start":"2026-05-11T10:44:20.998243Z","end":"2026-05-11T10:44:21.114545Z","steps":["trace[722618664] 'read index received' (duration: 116.183394ms)","trace[722618664] 'applied index is now lower than readState.Index' (duration: 117.065µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:21.114814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.51754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:21.114871Z","caller":"traceutil/trace.go:171","msg":"trace[813569550] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:117; }","duration":"116.660813ms","start":"2026-05-11T10:44:20.998199Z","end":"2026-05-11T10:44:21.11486Z","steps":["trace[813569550] 'agreement among raft nodes before linearized reading' (duration: 116.406874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:21.931723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.172357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:21.931849Z","caller":"traceutil/trace.go:171","msg":"trace[876262381] linearizableReadLoop","detail":"{readStateIndex:125; appliedIndex:123; }","duration":"716.877479ms","start":"2026-05-11T10:44:21.214955Z","end":"2026-05-11T10:44:21.931833Z","steps":["trace[876262381] 'read index received' (duration: 63.143583ms)","trace[876262381] 'applied index is now lower than readState.Index' (duration: 653.732466ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:21.932078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.780843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d4719910\" ","response":"range_response_count:1 size:648"} {"level":"info","ts":"2026-05-11T10:44:21.93203Z","caller":"traceutil/trace.go:171","msg":"trace[176608224] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"717.184666ms","start":"2026-05-11T10:44:21.214733Z","end":"2026-05-11T10:44:21.931917Z","steps":["trace[176608224] 'process raft request' (duration: 179.74329ms)","trace[176608224] 'compare' (duration: 536.944107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:21.932082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.108829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:44:21.932152Z","caller":"traceutil/trace.go:171","msg":"trace[639006321] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d4719910; range_end:; response_count:1; response_revision:120; }","duration":"650.887158ms","start":"2026-05-11T10:44:21.281255Z","end":"2026-05-11T10:44:21.932142Z","steps":["trace[639006321] 'agreement among raft nodes before linearized reading' (duration: 650.767824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:21.932191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:21.281239Z","time spent":"650.943637ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":670,"request content":"key:\"/registry/events/default/instance.18ae7ce6d4719910\" "} {"level":"info","ts":"2026-05-11T10:44:21.93219Z","caller":"traceutil/trace.go:171","msg":"trace[163542975] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:0; response_revision:120; }","duration":"717.256523ms","start":"2026-05-11T10:44:21.214914Z","end":"2026-05-11T10:44:21.93217Z","steps":["trace[163542975] 'agreement among raft nodes before linearized reading' (duration: 717.043952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:21.93224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:21.214904Z","time spent":"717.328559ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:kube-aggregator\" "} {"level":"warn","ts":"2026-05-11T10:44:21.932262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:21.214711Z","time spent":"717.457854ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:21.932676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.343135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-11T10:44:21.932717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.847854ms","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-11T10:44:21.932759Z","caller":"traceutil/trace.go:171","msg":"trace[406460586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:120; }","duration":"561.469809ms","start":"2026-05-11T10:44:21.37127Z","end":"2026-05-11T10:44:21.93274Z","steps":["trace[406460586] 'agreement among raft nodes before linearized reading' (duration: 561.310106ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:21.932779Z","caller":"traceutil/trace.go:171","msg":"trace[973877208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:120; }","duration":"548.943529ms","start":"2026-05-11T10:44:21.383818Z","end":"2026-05-11T10:44:21.932762Z","steps":["trace[973877208] 'agreement among raft nodes before linearized reading' (duration: 548.797286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:21.93278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.971308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-05-11T10:44:21.932821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:21.371252Z","time spent":"561.544106ms","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-11T10:44:21.932829Z","caller":"traceutil/trace.go:171","msg":"trace[1020100320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:120; }","duration":"549.041985ms","start":"2026-05-11T10:44:21.383773Z","end":"2026-05-11T10:44:21.932815Z","steps":["trace[1020100320] 'agreement among raft nodes before linearized reading' (duration: 548.778656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:21.932829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:21.383811Z","time spent":"549.004017ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-11T10:44:21.932869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:21.383762Z","time spent":"549.098453ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T10:44:22.235094Z","caller":"traceutil/trace.go:171","msg":"trace[512206713] linearizableReadLoop","detail":"{readStateIndex:129; appliedIndex:126; }","duration":"246.542039ms","start":"2026-05-11T10:44:21.988524Z","end":"2026-05-11T10:44:22.235066Z","steps":["trace[512206713] 'read index received' (duration: 205.707812ms)","trace[512206713] 'applied index is now lower than readState.Index' (duration: 40.833157ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:22.235365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.733062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ae7ce6d47158e1\" ","response":"range_response_count:1 size:654"} {"level":"info","ts":"2026-05-11T10:44:22.23545Z","caller":"traceutil/trace.go:171","msg":"trace[1828610071] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"299.471124ms","start":"2026-05-11T10:44:21.93594Z","end":"2026-05-11T10:44:22.235412Z","steps":["trace[1828610071] 'process raft request' (duration: 258.33823ms)","trace[1828610071] 'compare' (duration: 40.593157ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:22.235478Z","caller":"traceutil/trace.go:171","msg":"trace[1545722091] range","detail":"{range_begin:/registry/events/default/instance.18ae7ce6d47158e1; range_end:; response_count:1; response_revision:124; }","duration":"246.98803ms","start":"2026-05-11T10:44:21.988472Z","end":"2026-05-11T10:44:22.23546Z","steps":["trace[1545722091] 'agreement among raft nodes before linearized reading' (duration: 246.693053ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:22.235471Z","caller":"traceutil/trace.go:171","msg":"trace[641260712] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"298.788905ms","start":"2026-05-11T10:44:21.936664Z","end":"2026-05-11T10:44:22.235453Z","steps":["trace[641260712] 'process raft request' (duration: 298.316294ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:22.235555Z","caller":"traceutil/trace.go:171","msg":"trace[1371814669] transaction","detail":"{read_only:false; response_revision:124; number_of_response:1; }","duration":"298.523156ms","start":"2026-05-11T10:44:21.937015Z","end":"2026-05-11T10:44:22.235539Z","steps":["trace[1371814669] 'process raft request' (duration: 298.018697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:22.542095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.955263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:44:22.542206Z","caller":"traceutil/trace.go:171","msg":"trace[1530486660] transaction","detail":"{read_only:false; response_revision:127; number_of_response:1; }","duration":"266.455419ms","start":"2026-05-11T10:44:22.275733Z","end":"2026-05-11T10:44:22.542188Z","steps":["trace[1530486660] 'process raft request' (duration: 165.338543ms)","trace[1530486660] 'compare' (duration: 100.818688ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:22.567221Z","caller":"traceutil/trace.go:171","msg":"trace[149406057] transaction","detail":"{read_only:false; response_revision:128; number_of_response:1; }","duration":"246.581563ms","start":"2026-05-11T10:44:22.320617Z","end":"2026-05-11T10:44:22.567198Z","steps":["trace[149406057] 'process raft request' (duration: 246.382162ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:22.567247Z","caller":"traceutil/trace.go:171","msg":"trace[462207180] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"216.710742ms","start":"2026-05-11T10:44:22.350519Z","end":"2026-05-11T10:44:22.56723Z","steps":["trace[462207180] 'process raft request' (duration: 216.620936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:22.769496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.534221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:22.769581Z","caller":"traceutil/trace.go:171","msg":"trace[852648563] linearizableReadLoop","detail":"{readStateIndex:136; appliedIndex:135; }","duration":"157.309656ms","start":"2026-05-11T10:44:22.612258Z","end":"2026-05-11T10:44:22.769568Z","steps":["trace[852648563] 'read index received' (duration: 29.688839ms)","trace[852648563] 'applied index is now lower than readState.Index' (duration: 127.620027ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:22.769661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.410042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:persistent-volume-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:22.769686Z","caller":"traceutil/trace.go:171","msg":"trace[467789403] range","detail":"{range_begin:/registry/clusterroles/system:persistent-volume-provisioner; range_end:; response_count:0; response_revision:131; }","duration":"157.440111ms","start":"2026-05-11T10:44:22.612239Z","end":"2026-05-11T10:44:22.769679Z","steps":["trace[467789403] 'agreement among raft nodes before linearized reading' (duration: 157.360844ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:22.769682Z","caller":"traceutil/trace.go:171","msg":"trace[658441306] transaction","detail":"{read_only:false; response_revision:131; number_of_response:1; }","duration":"196.366166ms","start":"2026-05-11T10:44:22.573274Z","end":"2026-05-11T10:44:22.76964Z","steps":["trace[658441306] 'process raft request' (duration: 68.633213ms)","trace[658441306] 'compare' (duration: 127.405557ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:23.22588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.013912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:23.225997Z","caller":"traceutil/trace.go:171","msg":"trace[1590189215] linearizableReadLoop","detail":"{readStateIndex:138; appliedIndex:137; }","duration":"360.209873ms","start":"2026-05-11T10:44:22.865766Z","end":"2026-05-11T10:44:23.225976Z","steps":["trace[1590189215] 'read index received' (duration: 248.023347ms)","trace[1590189215] 'applied index is now lower than readState.Index' (duration: 112.184756ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:23.22604Z","caller":"traceutil/trace.go:171","msg":"trace[1252661368] transaction","detail":"{read_only:false; response_revision:133; number_of_response:1; }","duration":"452.232816ms","start":"2026-05-11T10:44:22.773781Z","end":"2026-05-11T10:44:23.226013Z","steps":["trace[1252661368] 'process raft request' (duration: 340.012472ms)","trace[1252661368] 'compare' (duration: 111.870927ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:23.226144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:22.773744Z","time spent":"452.351821ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":740,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:23.226168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.250527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T10:44:23.226212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.436203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:23.226274Z","caller":"traceutil/trace.go:171","msg":"trace[1345819365] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient; range_end:; response_count:0; response_revision:133; }","duration":"360.528489ms","start":"2026-05-11T10:44:22.86573Z","end":"2026-05-11T10:44:23.226259Z","steps":["trace[1345819365] 'agreement among raft nodes before linearized reading' (duration: 360.354626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:23.226325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:22.865714Z","time spent":"360.599396ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" "} {"level":"info","ts":"2026-05-11T10:44:23.226197Z","caller":"traceutil/trace.go:171","msg":"trace[556776864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:133; }","duration":"254.343333ms","start":"2026-05-11T10:44:22.971845Z","end":"2026-05-11T10:44:23.226188Z","steps":["trace[556776864] 'agreement among raft nodes before linearized reading' (duration: 254.276896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:23.516425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.565262ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:23.516542Z","caller":"traceutil/trace.go:171","msg":"trace[1520414524] linearizableReadLoop","detail":"{readStateIndex:141; appliedIndex:140; }","duration":"205.430194ms","start":"2026-05-11T10:44:23.311094Z","end":"2026-05-11T10:44:23.516525Z","steps":["trace[1520414524] 'read index received' (duration: 32.628072ms)","trace[1520414524] 'applied index is now lower than readState.Index' (duration: 172.800782ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:23.516595Z","caller":"traceutil/trace.go:171","msg":"trace[744558356] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"242.013178ms","start":"2026-05-11T10:44:23.274546Z","end":"2026-05-11T10:44:23.516559Z","steps":["trace[744558356] 'process raft request' (duration: 69.217396ms)","trace[744558356] 'compare' (duration: 172.432507ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:23.516758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.626856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:23.516859Z","caller":"traceutil/trace.go:171","msg":"trace[1429784580] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient; range_end:; response_count:0; response_revision:136; }","duration":"205.77396ms","start":"2026-05-11T10:44:23.311059Z","end":"2026-05-11T10:44:23.516833Z","steps":["trace[1429784580] 'agreement among raft nodes before linearized reading' (duration: 205.53397ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:23.654579Z","caller":"traceutil/trace.go:171","msg":"trace[918984727] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"130.699189ms","start":"2026-05-11T10:44:23.523855Z","end":"2026-05-11T10:44:23.654554Z","steps":["trace[918984727] 'process raft request' (duration: 130.642731ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:23.654621Z","caller":"traceutil/trace.go:171","msg":"trace[406290016] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"133.828334ms","start":"2026-05-11T10:44:23.520753Z","end":"2026-05-11T10:44:23.654581Z","steps":["trace[406290016] 'process raft request' (duration: 103.650305ms)","trace[406290016] 'compare' (duration: 29.932168ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:23.841448Z","caller":"traceutil/trace.go:171","msg":"trace[1169805963] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"126.900029ms","start":"2026-05-11T10:44:23.71453Z","end":"2026-05-11T10:44:23.84143Z","steps":["trace[1169805963] 'process raft request' (duration: 126.865221ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:23.842054Z","caller":"traceutil/trace.go:171","msg":"trace[584899720] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"127.62175ms","start":"2026-05-11T10:44:23.714262Z","end":"2026-05-11T10:44:23.841883Z","steps":["trace[584899720] 'process raft request' (duration: 51.73639ms)","trace[584899720] 'compare' (duration: 75.279385ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:24.167699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.620344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:24.168168Z","caller":"traceutil/trace.go:171","msg":"trace[1271476010] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"319.687057ms","start":"2026-05-11T10:44:23.84846Z","end":"2026-05-11T10:44:24.168147Z","steps":["trace[1271476010] 'process raft request' (duration: 184.314692ms)","trace[1271476010] 'compare' (duration: 134.400182ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:24.168347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:23.848438Z","time spent":"319.876999ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:24.168351Z","caller":"traceutil/trace.go:171","msg":"trace[689230535] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"316.585001ms","start":"2026-05-11T10:44:23.851721Z","end":"2026-05-11T10:44:24.168306Z","steps":["trace[689230535] 'process raft request' (duration: 316.067941ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:24.16853Z","caller":"traceutil/trace.go:171","msg":"trace[646606730] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"295.979972ms","start":"2026-05-11T10:44:23.872537Z","end":"2026-05-11T10:44:24.168517Z","steps":["trace[646606730] 'process raft request' (duration: 295.323437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:24.168604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:23.851707Z","time spent":"316.757784ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4645,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:24.495621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.159409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:24.495968Z","caller":"traceutil/trace.go:171","msg":"trace[1583511651] transaction","detail":"{read_only:false; response_revision:149; number_of_response:1; }","duration":"322.085022ms","start":"2026-05-11T10:44:24.173856Z","end":"2026-05-11T10:44:24.495941Z","steps":["trace[1583511651] 'process raft request' (duration: 167.528899ms)","trace[1583511651] 'compare' (duration: 153.971585ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:24.496047Z","caller":"traceutil/trace.go:171","msg":"trace[949084908] linearizableReadLoop","detail":"{readStateIndex:156; appliedIndex:153; }","duration":"256.245944ms","start":"2026-05-11T10:44:24.239786Z","end":"2026-05-11T10:44:24.496032Z","steps":["trace[949084908] 'read index received' (duration: 101.592135ms)","trace[949084908] 'applied index is now lower than readState.Index' (duration: 154.652979ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:24.49607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.173845Z","time spent":"322.177318ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:24.49623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.436686ms","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-11T10:44:24.496261Z","caller":"traceutil/trace.go:171","msg":"trace[785316270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:151; }","duration":"256.468965ms","start":"2026-05-11T10:44:24.23978Z","end":"2026-05-11T10:44:24.496249Z","steps":["trace[785316270] 'agreement among raft nodes before linearized reading' (duration: 256.401348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:24.496365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.429557ms","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-11T10:44:24.496397Z","caller":"traceutil/trace.go:171","msg":"trace[282166642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:151; }","duration":"256.537543ms","start":"2026-05-11T10:44:24.23985Z","end":"2026-05-11T10:44:24.496387Z","steps":["trace[282166642] 'agreement among raft nodes before linearized reading' (duration: 256.482795ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:24.496431Z","caller":"traceutil/trace.go:171","msg":"trace[920473377] transaction","detail":"{read_only:false; response_revision:150; number_of_response:1; }","duration":"316.586491ms","start":"2026-05-11T10:44:24.179835Z","end":"2026-05-11T10:44:24.496421Z","steps":["trace[920473377] 'process raft request' (duration: 315.929167ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:24.496466Z","caller":"traceutil/trace.go:171","msg":"trace[1660674648] transaction","detail":"{read_only:false; response_revision:151; number_of_response:1; }","duration":"292.567947ms","start":"2026-05-11T10:44:24.203864Z","end":"2026-05-11T10:44:24.496432Z","steps":["trace[1660674648] 'process raft request' (duration: 292.077636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:24.496491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.179813Z","time spent":"316.641109ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:25.257836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.843142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:25.258019Z","caller":"traceutil/trace.go:171","msg":"trace[582792158] linearizableReadLoop","detail":"{readStateIndex:161; appliedIndex:157; }","duration":"687.113018ms","start":"2026-05-11T10:44:24.57089Z","end":"2026-05-11T10:44:25.258003Z","steps":["trace[582792158] 'read index received' (duration: 177.030576ms)","trace[582792158] 'applied index is now lower than readState.Index' (duration: 510.081892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:25.258107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.217135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:25.25811Z","caller":"traceutil/trace.go:171","msg":"trace[336402959] transaction","detail":"{read_only:false; response_revision:154; number_of_response:1; }","duration":"757.478264ms","start":"2026-05-11T10:44:24.500559Z","end":"2026-05-11T10:44:25.258037Z","steps":["trace[336402959] 'process raft request' (duration: 757.352249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.258222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.500537Z","time spent":"757.631098ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:25.258291Z","caller":"traceutil/trace.go:171","msg":"trace[145487685] transaction","detail":"{read_only:false; response_revision:155; number_of_response:1; }","duration":"756.217033ms","start":"2026-05-11T10:44:24.50206Z","end":"2026-05-11T10:44:25.258277Z","steps":["trace[145487685] 'process raft request' (duration: 755.885215ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:25.258127Z","caller":"traceutil/trace.go:171","msg":"trace[1644916980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:156; }","duration":"687.276712ms","start":"2026-05-11T10:44:24.570842Z","end":"2026-05-11T10:44:25.258119Z","steps":["trace[1644916980] 'agreement among raft nodes before linearized reading' (duration: 687.197465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.258357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.502045Z","time spent":"756.28131ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:25.258386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.57082Z","time spent":"687.544742ms","remote":"127.0.0.1:53542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-11T10:44:25.258338Z","caller":"traceutil/trace.go:171","msg":"trace[1047910268] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"701.141463ms","start":"2026-05-11T10:44:24.557153Z","end":"2026-05-11T10:44:25.258294Z","steps":["trace[1047910268] 'process raft request' (duration: 700.824115ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:25.25839Z","caller":"traceutil/trace.go:171","msg":"trace[1619295175] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"757.785743ms","start":"2026-05-11T10:44:24.500558Z","end":"2026-05-11T10:44:25.258343Z","steps":["trace[1619295175] 'process raft request' (duration: 247.379002ms)","trace[1619295175] 'compare' (duration: 509.512624ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:25.25852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.557136Z","time spent":"701.309957ms","remote":"127.0.0.1:53630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:44:25.258606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:24.500538Z","time spent":"757.949006ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:25.541179Z","caller":"traceutil/trace.go:171","msg":"trace[1572080942] transaction","detail":"{read_only:false; response_revision:159; number_of_response:1; }","duration":"263.136448ms","start":"2026-05-11T10:44:25.278019Z","end":"2026-05-11T10:44:25.541156Z","steps":["trace[1572080942] 'process raft request' (duration: 263.07345ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:25.541211Z","caller":"traceutil/trace.go:171","msg":"trace[1310264525] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"276.804069ms","start":"2026-05-11T10:44:25.264358Z","end":"2026-05-11T10:44:25.541162Z","steps":["trace[1310264525] 'process raft request' (duration: 210.035087ms)","trace[1310264525] 'compare' (duration: 66.499842ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:26.156187Z","caller":"traceutil/trace.go:171","msg":"trace[632929928] transaction","detail":"{read_only:false; response_revision:166; number_of_response:1; }","duration":"257.208478ms","start":"2026-05-11T10:44:25.898945Z","end":"2026-05-11T10:44:26.156153Z","steps":["trace[632929928] 'process raft request' (duration: 160.788936ms)","trace[632929928] 'compare' (duration: 96.17268ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:26.499061Z","caller":"traceutil/trace.go:171","msg":"trace[24856083] linearizableReadLoop","detail":"{readStateIndex:175; appliedIndex:174; }","duration":"227.28954ms","start":"2026-05-11T10:44:26.271725Z","end":"2026-05-11T10:44:26.499014Z","steps":["trace[24856083] 'read index received' (duration: 137.186698ms)","trace[24856083] 'applied index is now lower than readState.Index' (duration: 90.100352ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:26.499288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.543991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:26.499336Z","caller":"traceutil/trace.go:171","msg":"trace[824773605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:170; }","duration":"227.615949ms","start":"2026-05-11T10:44:26.271707Z","end":"2026-05-11T10:44:26.499323Z","steps":["trace[824773605] 'agreement among raft nodes before linearized reading' (duration: 227.455335ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:26.499613Z","caller":"traceutil/trace.go:171","msg":"trace[1398834483] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"253.232514ms","start":"2026-05-11T10:44:26.246322Z","end":"2026-05-11T10:44:26.499555Z","steps":["trace[1398834483] 'process raft request' (duration: 162.590691ms)","trace[1398834483] 'compare' (duration: 89.893349ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:26.92993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.616048ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:26.930054Z","caller":"traceutil/trace.go:171","msg":"trace[2017853474] linearizableReadLoop","detail":"{readStateIndex:178; appliedIndex:177; }","duration":"258.408543ms","start":"2026-05-11T10:44:26.671625Z","end":"2026-05-11T10:44:26.930033Z","steps":["trace[2017853474] 'read index received' (duration: 56.558µs)","trace[2017853474] 'applied index is now lower than readState.Index' (duration: 258.350385ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:26.930171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.544479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:26.930194Z","caller":"traceutil/trace.go:171","msg":"trace[1443527089] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"334.013832ms","start":"2026-05-11T10:44:26.59615Z","end":"2026-05-11T10:44:26.930163Z","steps":["trace[1443527089] 'process raft request' (duration: 43.086455ms)","trace[1443527089] 'compare' (duration: 290.450564ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:26.930219Z","caller":"traceutil/trace.go:171","msg":"trace[851086962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:173; }","duration":"258.646615ms","start":"2026-05-11T10:44:26.671559Z","end":"2026-05-11T10:44:26.930205Z","steps":["trace[851086962] 'agreement among raft nodes before linearized reading' (duration: 258.532359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:26.930335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:26.596125Z","time spent":"334.142278ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:27.092543Z","caller":"traceutil/trace.go:171","msg":"trace[1096867590] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"156.605079ms","start":"2026-05-11T10:44:26.935899Z","end":"2026-05-11T10:44:27.092504Z","steps":["trace[1096867590] 'process raft request' (duration: 100.973035ms)","trace[1096867590] 'compare' (duration: 55.419131ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:27.35775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.240369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:27.357882Z","caller":"traceutil/trace.go:171","msg":"trace[38203126] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"178.346491ms","start":"2026-05-11T10:44:27.179504Z","end":"2026-05-11T10:44:27.357851Z","steps":["trace[38203126] 'process raft request' (duration: 51.932997ms)","trace[38203126] 'compare' (duration: 126.084645ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:27.555009Z","caller":"traceutil/trace.go:171","msg":"trace[840096862] transaction","detail":"{read_only:false; response_revision:180; number_of_response:1; }","duration":"191.936578ms","start":"2026-05-11T10:44:27.363047Z","end":"2026-05-11T10:44:27.554983Z","steps":["trace[840096862] 'process raft request' (duration: 191.891259ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:27.555054Z","caller":"traceutil/trace.go:171","msg":"trace[1385004282] transaction","detail":"{read_only:false; response_revision:179; number_of_response:1; }","duration":"192.059943ms","start":"2026-05-11T10:44:27.362973Z","end":"2026-05-11T10:44:27.555033Z","steps":["trace[1385004282] 'process raft request' (duration: 191.85581ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:27.555045Z","caller":"traceutil/trace.go:171","msg":"trace[1533474266] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"192.087462ms","start":"2026-05-11T10:44:27.362927Z","end":"2026-05-11T10:44:27.555014Z","steps":["trace[1533474266] 'process raft request' (duration: 96.488732ms)","trace[1533474266] 'compare' (duration: 95.222633ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:27.882107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.32676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:27.882207Z","caller":"traceutil/trace.go:171","msg":"trace[1515130277] linearizableReadLoop","detail":"{readStateIndex:188; appliedIndex:187; }","duration":"210.43631ms","start":"2026-05-11T10:44:27.671752Z","end":"2026-05-11T10:44:27.882188Z","steps":["trace[1515130277] 'read index received' (duration: 93.966915ms)","trace[1515130277] 'applied index is now lower than readState.Index' (duration: 116.468475ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:27.882313Z","caller":"traceutil/trace.go:171","msg":"trace[1342415235] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"264.984421ms","start":"2026-05-11T10:44:27.617274Z","end":"2026-05-11T10:44:27.882258Z","steps":["trace[1342415235] 'process raft request' (duration: 148.437738ms)","trace[1342415235] 'compare' (duration: 116.177195ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:27.882445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.683241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:27.88248Z","caller":"traceutil/trace.go:171","msg":"trace[1457572678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:183; }","duration":"210.74545ms","start":"2026-05-11T10:44:27.671722Z","end":"2026-05-11T10:44:27.882468Z","steps":["trace[1457572678] 'agreement among raft nodes before linearized reading' (duration: 210.511968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:28.152586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.147522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:28.152712Z","caller":"traceutil/trace.go:171","msg":"trace[1604721826] transaction","detail":"{read_only:false; response_revision:186; number_of_response:1; }","duration":"170.24108ms","start":"2026-05-11T10:44:27.982447Z","end":"2026-05-11T10:44:28.152688Z","steps":["trace[1604721826] 'process raft request' (duration: 35.913723ms)","trace[1604721826] 'compare' (duration: 133.967879ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:28.321948Z","caller":"traceutil/trace.go:171","msg":"trace[1017837392] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"148.726878ms","start":"2026-05-11T10:44:28.173195Z","end":"2026-05-11T10:44:28.321922Z","steps":["trace[1017837392] 'process raft request' (duration: 135.098062ms)","trace[1017837392] 'compare' (duration: 13.330196ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:28.70141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.400732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:28.701915Z","caller":"traceutil/trace.go:171","msg":"trace[1927767178] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"289.666995ms","start":"2026-05-11T10:44:28.412178Z","end":"2026-05-11T10:44:28.701845Z","steps":["trace[1927767178] 'process raft request' (duration: 125.75871ms)","trace[1927767178] 'compare' (duration: 163.254326ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:28.948588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.015349ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:28.948694Z","caller":"traceutil/trace.go:171","msg":"trace[1230652069] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"148.136076ms","start":"2026-05-11T10:44:28.800542Z","end":"2026-05-11T10:44:28.948678Z","steps":["trace[1230652069] 'compare' (duration: 137.873113ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:29.153614Z","caller":"traceutil/trace.go:171","msg":"trace[1193303283] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"171.457584ms","start":"2026-05-11T10:44:28.982134Z","end":"2026-05-11T10:44:29.153591Z","steps":["trace[1193303283] 'process raft request' (duration: 84.622574ms)","trace[1193303283] 'compare' (duration: 86.728643ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:29.428819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.744766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:29.429023Z","caller":"traceutil/trace.go:171","msg":"trace[867889938] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"177.022538ms","start":"2026-05-11T10:44:29.251967Z","end":"2026-05-11T10:44:29.428989Z","steps":["trace[867889938] 'process raft request' (duration: 30.056789ms)","trace[867889938] 'compare' (duration: 146.557292ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:29.727381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.597927ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:29.727651Z","caller":"traceutil/trace.go:171","msg":"trace[1928854555] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"221.827672ms","start":"2026-05-11T10:44:29.505783Z","end":"2026-05-11T10:44:29.727611Z","steps":["trace[1928854555] 'process raft request' (duration: 27.917384ms)","trace[1928854555] 'compare' (duration: 193.372013ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:29.727891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.454789ms","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-11T10:44:29.728015Z","caller":"traceutil/trace.go:171","msg":"trace[1747600472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:202; }","duration":"168.587175ms","start":"2026-05-11T10:44:29.559354Z","end":"2026-05-11T10:44:29.727941Z","steps":["trace[1747600472] 'agreement among raft nodes before linearized reading' (duration: 168.336522ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:29.72877Z","caller":"traceutil/trace.go:171","msg":"trace[1114932300] linearizableReadLoop","detail":"{readStateIndex:207; appliedIndex:206; }","duration":"168.185657ms","start":"2026-05-11T10:44:29.559397Z","end":"2026-05-11T10:44:29.727582Z","steps":["trace[1114932300] 'read index received' (duration: 85.558µs)","trace[1114932300] 'applied index is now lower than readState.Index' (duration: 168.098479ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:29.729029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.562614ms","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-11T10:44:29.729115Z","caller":"traceutil/trace.go:171","msg":"trace[1726863524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:202; }","duration":"169.662431ms","start":"2026-05-11T10:44:29.559433Z","end":"2026-05-11T10:44:29.729095Z","steps":["trace[1726863524] 'agreement among raft nodes before linearized reading' (duration: 169.495187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:30.054819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.453068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:volume-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:30.054986Z","caller":"traceutil/trace.go:171","msg":"trace[447979016] range","detail":"{range_begin:/registry/clusterrolebindings/system:volume-scheduler; range_end:; response_count:0; response_revision:206; }","duration":"226.678651ms","start":"2026-05-11T10:44:29.828287Z","end":"2026-05-11T10:44:30.054966Z","steps":["trace[447979016] 'range keys from in-memory index tree' (duration: 226.372359ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:30.490667Z","caller":"traceutil/trace.go:171","msg":"trace[1138919240] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"278.237049ms","start":"2026-05-11T10:44:30.212396Z","end":"2026-05-11T10:44:30.490633Z","steps":["trace[1138919240] 'process raft request' (duration: 212.155841ms)","trace[1138919240] 'compare' (duration: 65.880914ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:30.684229Z","caller":"traceutil/trace.go:171","msg":"trace[1374394681] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"139.277391ms","start":"2026-05-11T10:44:30.544911Z","end":"2026-05-11T10:44:30.684188Z","steps":["trace[1374394681] 'process raft request' (duration: 51.45556ms)","trace[1374394681] 'compare' (duration: 87.630166ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:30.8725Z","caller":"traceutil/trace.go:171","msg":"trace[730768288] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:219; }","duration":"101.370812ms","start":"2026-05-11T10:44:30.771105Z","end":"2026-05-11T10:44:30.872476Z","steps":["trace[730768288] 'read index received' (duration: 34.306802ms)","trace[730768288] 'applied index is now lower than readState.Index' (duration: 67.06315ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:30.872644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.531557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:30.872674Z","caller":"traceutil/trace.go:171","msg":"trace[1483048575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:215; }","duration":"101.614794ms","start":"2026-05-11T10:44:30.77105Z","end":"2026-05-11T10:44:30.872665Z","steps":["trace[1483048575] 'agreement among raft nodes before linearized reading' (duration: 101.513657ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:30.872834Z","caller":"traceutil/trace.go:171","msg":"trace[1900156236] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"163.22245ms","start":"2026-05-11T10:44:30.709579Z","end":"2026-05-11T10:44:30.872801Z","steps":["trace[1900156236] 'process raft request' (duration: 95.880909ms)","trace[1900156236] 'compare' (duration: 66.904264ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:31.11502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.069624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:31.115171Z","caller":"traceutil/trace.go:171","msg":"trace[44035327] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"147.307704ms","start":"2026-05-11T10:44:30.967834Z","end":"2026-05-11T10:44:31.115142Z","steps":["trace[44035327] 'process raft request' (duration: 22.004087ms)","trace[44035327] 'compare' (duration: 124.804801ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:31.276022Z","caller":"traceutil/trace.go:171","msg":"trace[1512897225] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"155.794494ms","start":"2026-05-11T10:44:31.120196Z","end":"2026-05-11T10:44:31.27599Z","steps":["trace[1512897225] 'process raft request' (duration: 143.175979ms)","trace[1512897225] 'compare' (duration: 12.42728ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:31.520118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.707043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:31.520411Z","caller":"traceutil/trace.go:171","msg":"trace[900333996] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"169.752054ms","start":"2026-05-11T10:44:31.350617Z","end":"2026-05-11T10:44:31.520369Z","steps":["trace[900333996] 'process raft request' (duration: 44.729618ms)","trace[900333996] 'compare' (duration: 124.578677ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:31.732723Z","caller":"traceutil/trace.go:171","msg":"trace[798114875] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"153.38798ms","start":"2026-05-11T10:44:31.579303Z","end":"2026-05-11T10:44:31.732691Z","steps":["trace[798114875] 'process raft request' (duration: 76.990267ms)","trace[798114875] 'compare' (duration: 75.980295ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:32.093639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.9395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:32.093756Z","caller":"traceutil/trace.go:171","msg":"trace[835933730] linearizableReadLoop","detail":"{readStateIndex:233; appliedIndex:232; }","duration":"297.544443ms","start":"2026-05-11T10:44:31.796197Z","end":"2026-05-11T10:44:32.093742Z","steps":["trace[835933730] 'read index received' (duration: 171.371909ms)","trace[835933730] 'applied index is now lower than readState.Index' (duration: 126.171304ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:32.093946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.650404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:32.094034Z","caller":"traceutil/trace.go:171","msg":"trace[287152165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:228; }","duration":"239.78909ms","start":"2026-05-11T10:44:31.854229Z","end":"2026-05-11T10:44:32.094018Z","steps":["trace[287152165] 'agreement among raft nodes before linearized reading' (duration: 239.615825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:32.09405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.844765ms","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-11T10:44:32.094082Z","caller":"traceutil/trace.go:171","msg":"trace[874774439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:228; }","duration":"297.912133ms","start":"2026-05-11T10:44:31.796162Z","end":"2026-05-11T10:44:32.094074Z","steps":["trace[874774439] 'agreement among raft nodes before linearized reading' (duration: 297.6428ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:32.094357Z","caller":"traceutil/trace.go:171","msg":"trace[1162032220] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"318.364004ms","start":"2026-05-11T10:44:31.775412Z","end":"2026-05-11T10:44:32.093776Z","steps":["trace[1162032220] 'process raft request' (duration: 192.221139ms)","trace[1162032220] 'compare' (duration: 125.694756ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:32.094547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:31.775394Z","time spent":"319.054945ms","remote":"127.0.0.1:53894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":756,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:44:32.313319Z","caller":"traceutil/trace.go:171","msg":"trace[2119610238] linearizableReadLoop","detail":"{readStateIndex:238; appliedIndex:237; }","duration":"122.522561ms","start":"2026-05-11T10:44:32.190768Z","end":"2026-05-11T10:44:32.313291Z","steps":["trace[2119610238] 'read index received' (duration: 74.119942ms)","trace[2119610238] 'applied index is now lower than readState.Index' (duration: 48.401619ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:32.313477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.687957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:32.313585Z","caller":"traceutil/trace.go:171","msg":"trace[2144058368] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"132.64781ms","start":"2026-05-11T10:44:32.180806Z","end":"2026-05-11T10:44:32.313454Z","steps":["trace[2144058368] 'process raft request' (duration: 84.209392ms)","trace[2144058368] 'compare' (duration: 48.150706ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:32.313665Z","caller":"traceutil/trace.go:171","msg":"trace[1442604921] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:resourcequota-controller; range_end:; response_count:0; response_revision:233; }","duration":"122.768695ms","start":"2026-05-11T10:44:32.190733Z","end":"2026-05-11T10:44:32.313501Z","steps":["trace[1442604921] 'agreement among raft nodes before linearized reading' (duration: 122.663018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:32.575684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.736877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:32.575762Z","caller":"traceutil/trace.go:171","msg":"trace[1808491357] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-account-controller; range_end:; response_count:0; response_revision:235; }","duration":"161.824905ms","start":"2026-05-11T10:44:32.413919Z","end":"2026-05-11T10:44:32.575744Z","steps":["trace[1808491357] 'range keys from in-memory index tree' (duration: 161.649218ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:32.747698Z","caller":"traceutil/trace.go:171","msg":"trace[306430947] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"168.644659ms","start":"2026-05-11T10:44:32.579015Z","end":"2026-05-11T10:44:32.74766Z","steps":["trace[306430947] 'process raft request' (duration: 119.940688ms)","trace[306430947] 'compare' (duration: 48.554835ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:33.161209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.788675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:33.161322Z","caller":"traceutil/trace.go:171","msg":"trace[1176605311] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"147.814148ms","start":"2026-05-11T10:44:33.013488Z","end":"2026-05-11T10:44:33.161302Z","steps":["trace[1176605311] 'process raft request' (duration: 23.780739ms)","trace[1176605311] 'compare' (duration: 123.636199ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:33.578405Z","caller":"traceutil/trace.go:171","msg":"trace[554673681] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"130.702246ms","start":"2026-05-11T10:44:33.447676Z","end":"2026-05-11T10:44:33.578378Z","steps":["trace[554673681] 'process raft request' (duration: 107.110853ms)","trace[554673681] 'compare' (duration: 23.415608ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:33.806642Z","caller":"traceutil/trace.go:171","msg":"trace[635251864] linearizableReadLoop","detail":"{readStateIndex:262; appliedIndex:261; }","duration":"130.61562ms","start":"2026-05-11T10:44:33.676002Z","end":"2026-05-11T10:44:33.806618Z","steps":["trace[635251864] 'read index received' (duration: 98.612901ms)","trace[635251864] 'applied index is now lower than readState.Index' (duration: 32.001759ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:33.80677Z","caller":"traceutil/trace.go:171","msg":"trace[1145918705] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"161.162173ms","start":"2026-05-11T10:44:33.645584Z","end":"2026-05-11T10:44:33.806747Z","steps":["trace[1145918705] 'process raft request' (duration: 129.074377ms)","trace[1145918705] 'compare' (duration: 31.821853ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:33.806928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.906882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:33.807089Z","caller":"traceutil/trace.go:171","msg":"trace[1537146347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:257; }","duration":"131.091797ms","start":"2026-05-11T10:44:33.675955Z","end":"2026-05-11T10:44:33.807047Z","steps":["trace[1537146347] 'agreement among raft nodes before linearized reading' (duration: 130.839773ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:34.005728Z","caller":"traceutil/trace.go:171","msg":"trace[1296163940] linearizableReadLoop","detail":"{readStateIndex:267; appliedIndex:266; }","duration":"134.464397ms","start":"2026-05-11T10:44:33.871237Z","end":"2026-05-11T10:44:34.005702Z","steps":["trace[1296163940] 'read index received' (duration: 79.049799ms)","trace[1296163940] 'applied index is now lower than readState.Index' (duration: 55.412088ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:34.005874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.612974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:34.00591Z","caller":"traceutil/trace.go:171","msg":"trace[1123424385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:262; }","duration":"134.700812ms","start":"2026-05-11T10:44:33.8712Z","end":"2026-05-11T10:44:34.005901Z","steps":["trace[1123424385] 'agreement among raft nodes before linearized reading' (duration: 134.594404ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:34.006103Z","caller":"traceutil/trace.go:171","msg":"trace[1515643357] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"136.574776ms","start":"2026-05-11T10:44:33.869488Z","end":"2026-05-11T10:44:34.006062Z","steps":["trace[1515643357] 'process raft request' (duration: 80.717708ms)","trace[1515643357] 'compare' (duration: 55.361139ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:34.367856Z","caller":"traceutil/trace.go:171","msg":"trace[1069291304] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"161.215449ms","start":"2026-05-11T10:44:34.206613Z","end":"2026-05-11T10:44:34.367828Z","steps":["trace[1069291304] 'process raft request' (duration: 120.204663ms)","trace[1069291304] 'compare' (duration: 40.901339ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:34.594558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.23661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:34.594671Z","caller":"traceutil/trace.go:171","msg":"trace[1680327227] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:276; }","duration":"131.037034ms","start":"2026-05-11T10:44:34.463618Z","end":"2026-05-11T10:44:34.594655Z","steps":["trace[1680327227] 'read index received' (duration: 16.573819ms)","trace[1680327227] 'applied index is now lower than readState.Index' (duration: 114.461315ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:34.594702Z","caller":"traceutil/trace.go:171","msg":"trace[2059143554] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"175.326564ms","start":"2026-05-11T10:44:34.41934Z","end":"2026-05-11T10:44:34.594667Z","steps":["trace[2059143554] 'process raft request' (duration: 60.898828ms)","trace[2059143554] 'compare' (duration: 114.059684ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:34.594824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.205869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:34.594859Z","caller":"traceutil/trace.go:171","msg":"trace[962895959] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:0; response_revision:271; }","duration":"131.245228ms","start":"2026-05-11T10:44:34.463605Z","end":"2026-05-11T10:44:34.59485Z","steps":["trace[962895959] 'agreement among raft nodes before linearized reading' (duration: 131.094442ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:34.770355Z","caller":"traceutil/trace.go:171","msg":"trace[392198546] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:278; }","duration":"162.691974ms","start":"2026-05-11T10:44:34.607638Z","end":"2026-05-11T10:44:34.77033Z","steps":["trace[392198546] 'read index received' (duration: 103.290312ms)","trace[392198546] 'applied index is now lower than readState.Index' (duration: 59.400892ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:34.770451Z","caller":"traceutil/trace.go:171","msg":"trace[707954343] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"169.804021ms","start":"2026-05-11T10:44:34.600602Z","end":"2026-05-11T10:44:34.770406Z","steps":["trace[707954343] 'process raft request' (duration: 110.438928ms)","trace[707954343] 'compare' (duration: 58.999232ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:34.770611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.916319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:34.770688Z","caller":"traceutil/trace.go:171","msg":"trace[614167916] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:0; response_revision:273; }","duration":"163.071926ms","start":"2026-05-11T10:44:34.607598Z","end":"2026-05-11T10:44:34.77067Z","steps":["trace[614167916] 'agreement among raft nodes before linearized reading' (duration: 162.844941ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:34.967437Z","caller":"traceutil/trace.go:171","msg":"trace[673183347] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"110.424518ms","start":"2026-05-11T10:44:34.856979Z","end":"2026-05-11T10:44:34.967404Z","steps":["trace[673183347] 'process raft request' (duration: 35.17394ms)","trace[673183347] 'compare' (duration: 75.097151ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:34.981947Z","caller":"traceutil/trace.go:171","msg":"trace[440089513] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:282; }","duration":"124.604361ms","start":"2026-05-11T10:44:34.857323Z","end":"2026-05-11T10:44:34.981927Z","steps":["trace[440089513] 'read index received' (duration: 34.998394ms)","trace[440089513] 'applied index is now lower than readState.Index' (duration: 89.604987ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:34.982025Z","caller":"traceutil/trace.go:171","msg":"trace[1915775228] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"124.698798ms","start":"2026-05-11T10:44:34.857259Z","end":"2026-05-11T10:44:34.981958Z","steps":["trace[1915775228] 'process raft request' (duration: 124.590491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:34.982079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.739988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-11T10:44:34.982116Z","caller":"traceutil/trace.go:171","msg":"trace[1351992459] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:278; }","duration":"124.813186ms","start":"2026-05-11T10:44:34.857291Z","end":"2026-05-11T10:44:34.982105Z","steps":["trace[1351992459] 'agreement among raft nodes before linearized reading' (duration: 124.734108ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:35.349853Z","caller":"traceutil/trace.go:171","msg":"trace[845996101] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"116.621857ms","start":"2026-05-11T10:44:35.233203Z","end":"2026-05-11T10:44:35.349825Z","steps":["trace[845996101] 'process raft request' (duration: 39.381468ms)","trace[845996101] 'compare' (duration: 77.119072ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:35.643519Z","caller":"traceutil/trace.go:171","msg":"trace[845481500] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"198.25936ms","start":"2026-05-11T10:44:35.445229Z","end":"2026-05-11T10:44:35.643488Z","steps":["trace[845481500] 'process raft request' (duration: 154.753701ms)","trace[845481500] 'compare' (duration: 43.366942ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:35.64351Z","caller":"traceutil/trace.go:171","msg":"trace[1278164078] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:294; }","duration":"171.997228ms","start":"2026-05-11T10:44:35.471486Z","end":"2026-05-11T10:44:35.643484Z","steps":["trace[1278164078] 'read index received' (duration: 128.48852ms)","trace[1278164078] 'applied index is now lower than readState.Index' (duration: 43.507568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:35.644019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.517488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3672"} {"level":"info","ts":"2026-05-11T10:44:35.644087Z","caller":"traceutil/trace.go:171","msg":"trace[181780850] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:289; }","duration":"172.631025ms","start":"2026-05-11T10:44:35.471437Z","end":"2026-05-11T10:44:35.644068Z","steps":["trace[181780850] 'agreement among raft nodes before linearized reading' (duration: 172.175334ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:35.842762Z","caller":"traceutil/trace.go:171","msg":"trace[1561103273] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:297; }","duration":"104.124248ms","start":"2026-05-11T10:44:35.738608Z","end":"2026-05-11T10:44:35.842732Z","steps":["trace[1561103273] 'read index received' (duration: 45.557745ms)","trace[1561103273] 'applied index is now lower than readState.Index' (duration: 58.564983ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:35.843125Z","caller":"traceutil/trace.go:171","msg":"trace[322024024] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"106.31343ms","start":"2026-05-11T10:44:35.736743Z","end":"2026-05-11T10:44:35.843057Z","steps":["trace[322024024] 'process raft request' (duration: 47.484372ms)","trace[322024024] 'compare' (duration: 58.356207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:35.843541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.890811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-11T10:44:35.843761Z","caller":"traceutil/trace.go:171","msg":"trace[23129890] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:292; }","duration":"105.177335ms","start":"2026-05-11T10:44:35.73856Z","end":"2026-05-11T10:44:35.843737Z","steps":["trace[23129890] 'agreement among raft nodes before linearized reading' (duration: 104.519759ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:36.111011Z","caller":"traceutil/trace.go:171","msg":"trace[1921826947] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"218.315152ms","start":"2026-05-11T10:44:35.892666Z","end":"2026-05-11T10:44:36.110981Z","steps":["trace[1921826947] 'process raft request' (duration: 218.223554ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:36.111102Z","caller":"traceutil/trace.go:171","msg":"trace[1299826389] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"219.309811ms","start":"2026-05-11T10:44:35.891763Z","end":"2026-05-11T10:44:36.111073Z","steps":["trace[1299826389] 'process raft request' (duration: 143.112526ms)","trace[1299826389] 'compare' (duration: 75.845522ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:36.389339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.94453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:36.389437Z","caller":"traceutil/trace.go:171","msg":"trace[39586184] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"149.438381ms","start":"2026-05-11T10:44:36.239982Z","end":"2026-05-11T10:44:36.38942Z","steps":["trace[39586184] 'read index received' (duration: 35.382423ms)","trace[39586184] 'applied index is now lower than readState.Index' (duration: 114.054738ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:36.389538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.555279ms","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-11T10:44:36.389636Z","caller":"traceutil/trace.go:171","msg":"trace[1779979600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:300; }","duration":"149.674647ms","start":"2026-05-11T10:44:36.239948Z","end":"2026-05-11T10:44:36.389622Z","steps":["trace[1779979600] 'agreement among raft nodes before linearized reading' (duration: 149.5201ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:36.389713Z","caller":"traceutil/trace.go:171","msg":"trace[1068561871] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"176.264187ms","start":"2026-05-11T10:44:36.213404Z","end":"2026-05-11T10:44:36.389669Z","steps":["trace[1068561871] 'process raft request' (duration: 61.927385ms)","trace[1068561871] 'compare' (duration: 113.843322ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:36.885998Z","caller":"traceutil/trace.go:171","msg":"trace[1801843489] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:314; }","duration":"121.89664ms","start":"2026-05-11T10:44:36.764074Z","end":"2026-05-11T10:44:36.88597Z","steps":["trace[1801843489] 'read index received' (duration: 38.129998ms)","trace[1801843489] 'applied index is now lower than readState.Index' (duration: 83.765812ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:36.886099Z","caller":"traceutil/trace.go:171","msg":"trace[1673397107] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"163.610533ms","start":"2026-05-11T10:44:36.722458Z","end":"2026-05-11T10:44:36.886068Z","steps":["trace[1673397107] 'process raft request' (duration: 79.807441ms)","trace[1673397107] 'compare' (duration: 83.575196ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:36.886587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.488958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-11T10:44:36.886654Z","caller":"traceutil/trace.go:171","msg":"trace[268146191] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:309; }","duration":"122.600505ms","start":"2026-05-11T10:44:36.764037Z","end":"2026-05-11T10:44:36.886637Z","steps":["trace[268146191] 'agreement among raft nodes before linearized reading' (duration: 122.435298ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:40.216186Z","caller":"traceutil/trace.go:171","msg":"trace[735597654] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:401; }","duration":"107.790131ms","start":"2026-05-11T10:44:40.108374Z","end":"2026-05-11T10:44:40.216164Z","steps":["trace[735597654] 'read index received' (duration: 75.87433ms)","trace[735597654] 'applied index is now lower than readState.Index' (duration: 31.914941ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:40.216368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.972068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-05-11T10:44:40.216439Z","caller":"traceutil/trace.go:171","msg":"trace[986607336] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:389; }","duration":"108.073017ms","start":"2026-05-11T10:44:40.108352Z","end":"2026-05-11T10:44:40.216425Z","steps":["trace[986607336] 'agreement among raft nodes before linearized reading' (duration: 107.8969ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:40.216403Z","caller":"traceutil/trace.go:171","msg":"trace[485334824] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"108.076227ms","start":"2026-05-11T10:44:40.108293Z","end":"2026-05-11T10:44:40.216369Z","steps":["trace[485334824] 'process raft request' (duration: 76.034248ms)","trace[485334824] 'compare' (duration: 31.714104ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:41.81369Z","caller":"traceutil/trace.go:171","msg":"trace[1461589469] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"161.047412ms","start":"2026-05-11T10:44:41.652626Z","end":"2026-05-11T10:44:41.813674Z","steps":["trace[1461589469] 'process raft request' (duration: 160.959644ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:42.946591Z","caller":"traceutil/trace.go:171","msg":"trace[100065318] linearizableReadLoop","detail":"{readStateIndex:415; appliedIndex:414; }","duration":"404.03782ms","start":"2026-05-11T10:44:42.542523Z","end":"2026-05-11T10:44:42.946561Z","steps":["trace[100065318] 'read index received' (duration: 403.889362ms)","trace[100065318] 'applied index is now lower than readState.Index' (duration: 147.488µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:42.94663Z","caller":"traceutil/trace.go:171","msg":"trace[1601282924] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"447.040481ms","start":"2026-05-11T10:44:42.499566Z","end":"2026-05-11T10:44:42.946606Z","steps":["trace[1601282924] 'process raft request' (duration: 446.774895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:42.946761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.225368ms","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-11T10:44:42.946787Z","caller":"traceutil/trace.go:171","msg":"trace[153455640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:401; }","duration":"404.304548ms","start":"2026-05-11T10:44:42.542476Z","end":"2026-05-11T10:44:42.946781Z","steps":["trace[153455640] 'agreement among raft nodes before linearized reading' (duration: 404.197039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:42.946784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:42.499555Z","time spent":"447.147601ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:42.946824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:42.542456Z","time spent":"404.358927ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T10:44:43.241786Z","caller":"traceutil/trace.go:171","msg":"trace[1681076671] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"292.014374ms","start":"2026-05-11T10:44:42.949751Z","end":"2026-05-11T10:44:43.241766Z","steps":["trace[1681076671] 'read index received' (duration: 284.597357ms)","trace[1681076671] 'applied index is now lower than readState.Index' (duration: 7.416007ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:43.241872Z","caller":"traceutil/trace.go:171","msg":"trace[57328332] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"405.071189ms","start":"2026-05-11T10:44:42.836792Z","end":"2026-05-11T10:44:43.241863Z","steps":["trace[57328332] 'process raft request' (duration: 397.544534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.241992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.209301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7293"} {"level":"warn","ts":"2026-05-11T10:44:43.24196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:42.836765Z","time spent":"405.126218ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:43.242048Z","caller":"traceutil/trace.go:171","msg":"trace[1215945387] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:402; }","duration":"292.30665ms","start":"2026-05-11T10:44:42.949729Z","end":"2026-05-11T10:44:43.242036Z","steps":["trace[1215945387] 'agreement among raft nodes before linearized reading' (duration: 292.190272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.250376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.09838ms","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-11T10:44:43.250435Z","caller":"traceutil/trace.go:171","msg":"trace[1577276682] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:403; }","duration":"130.215748ms","start":"2026-05-11T10:44:43.120205Z","end":"2026-05-11T10:44:43.25042Z","steps":["trace[1577276682] 'agreement among raft nodes before linearized reading' (duration: 130.11211ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:43.250476Z","caller":"traceutil/trace.go:171","msg":"trace[1650147935] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"300.634166ms","start":"2026-05-11T10:44:42.949809Z","end":"2026-05-11T10:44:43.250443Z","steps":["trace[1650147935] 'process raft request' (duration: 300.426879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.250623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:42.949783Z","time spent":"300.765295ms","remote":"127.0.0.1:53830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:03.90847Z","caller":"traceutil/trace.go:171","msg":"trace[732303108] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"105.105128ms","start":"2026-05-11T10:45:03.803341Z","end":"2026-05-11T10:45:03.908447Z","steps":["trace[732303108] 'process raft request' (duration: 104.792486ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:07.096478Z","caller":"traceutil/trace.go:171","msg":"trace[143720916] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"161.781153ms","start":"2026-05-11T10:45:06.934672Z","end":"2026-05-11T10:45:07.096453Z","steps":["trace[143720916] 'process raft request' (duration: 161.514659ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:07.097085Z","caller":"traceutil/trace.go:171","msg":"trace[2138567918] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"161.969116ms","start":"2026-05-11T10:45:06.935102Z","end":"2026-05-11T10:45:07.097071Z","steps":["trace[2138567918] 'process raft request' (duration: 161.880945ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:10.773584Z","caller":"traceutil/trace.go:171","msg":"trace[430212520] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"195.385731ms","start":"2026-05-11T10:45:10.578169Z","end":"2026-05-11T10:45:10.773555Z","steps":["trace[430212520] 'process raft request' (duration: 195.136437ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:11.038152Z","caller":"traceutil/trace.go:171","msg":"trace[496734467] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"168.89218ms","start":"2026-05-11T10:45:10.869234Z","end":"2026-05-11T10:45:11.038126Z","steps":["trace[496734467] 'process raft request' (duration: 161.552592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:11.677049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.508626ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:45:11.677154Z","caller":"traceutil/trace.go:171","msg":"trace[1087833268] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"217.561503ms","start":"2026-05-11T10:45:11.459577Z","end":"2026-05-11T10:45:11.677139Z","steps":["trace[1087833268] 'read index received' (duration: 34.28µs)","trace[1087833268] 'applied index is now lower than readState.Index' (duration: 217.526073ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:11.677253Z","caller":"traceutil/trace.go:171","msg":"trace[1078183544] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"585.185359ms","start":"2026-05-11T10:45:11.092033Z","end":"2026-05-11T10:45:11.677219Z","steps":["trace[1078183544] 'process raft request' (duration: 334.44681ms)","trace[1078183544] 'compare' (duration: 250.361742ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:11.677346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.762276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T10:45:11.677387Z","caller":"traceutil/trace.go:171","msg":"trace[232773463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"217.839818ms","start":"2026-05-11T10:45:11.459536Z","end":"2026-05-11T10:45:11.677376Z","steps":["trace[232773463] 'agreement among raft nodes before linearized reading' (duration: 217.682075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:11.677396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.899462ms","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":"warn","ts":"2026-05-11T10:45:11.677388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:11.092008Z","time spent":"585.325991ms","remote":"127.0.0.1:53804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:45:11.677347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.479357ms","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-11T10:45:11.677433Z","caller":"traceutil/trace.go:171","msg":"trace[1073657529] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:640; }","duration":"141.940303ms","start":"2026-05-11T10:45:11.535483Z","end":"2026-05-11T10:45:11.677423Z","steps":["trace[1073657529] 'agreement among raft nodes before linearized reading' (duration: 141.886582ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:11.677488Z","caller":"traceutil/trace.go:171","msg":"trace[765587640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"213.701961ms","start":"2026-05-11T10:45:11.463754Z","end":"2026-05-11T10:45:11.677456Z","steps":["trace[765587640] 'agreement among raft nodes before linearized reading' (duration: 213.484528ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:29.350438Z","caller":"traceutil/trace.go:171","msg":"trace[892009705] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"160.295417ms","start":"2026-05-11T10:45:29.190118Z","end":"2026-05-11T10:45:29.350414Z","steps":["trace[892009705] 'process raft request' (duration: 160.141443ms)"],"step_count":1}