{"level":"warn","ts":"2026-04-29T22:23:46.691846Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-29T22:23:46.691958Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-04-29T22:23:46.692027Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-29T22:23:46.692041Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-29T22:23:46.692063Z","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-04-29T22:23:46.692835Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-04-29T22:23:46.693043Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-04-29T22:23:46.697269Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.012441ms"} {"level":"info","ts":"2026-04-29T22:23:46.703078Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-04-29T22:23:46.70313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-04-29T22:23:46.703147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-04-29T22:23:46.703161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-29T22:23:46.703172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-04-29T22:23:46.703197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-04-29T22:23:46.708969Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-29T22:23:46.710073Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-29T22:23:46.711173Z","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-04-29T22:23:46.712895Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-29T22:23:46.713557Z","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-04-29T22:23:46.713589Z","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-04-29T22:23:46.713596Z","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-04-29T22:23:46.71649Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-29T22:23:46.716724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-04-29T22:23:46.716861Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-29T22:23:46.725775Z","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-04-29T22:23:46.725919Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-29T22:23:46.725943Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-29T22:23:46.726004Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-29T22:23:46.726091Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-29T22:23:47.604143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-04-29T22:23:47.604202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-29T22:23:47.604236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-04-29T22:23:47.604557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-04-29T22:23:47.604569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-29T22:23:47.604585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-04-29T22:23:47.604607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-29T22:23:47.605478Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-04-29T22:23:47.605525Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T22:23:47.605557Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T22:23:47.605654Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T22:23:47.60604Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-29T22:23:47.606111Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-29T22:23:47.606539Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T22:23:47.60671Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T22:23:47.606751Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T22:23:47.608723Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-29T22:23:47.609365Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-04-29T22:23:49.211502Z","caller":"traceutil/trace.go:171","msg":"trace[2090786708] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:7; }","duration":"186.771585ms","start":"2026-04-29T22:23:49.024702Z","end":"2026-04-29T22:23:49.211473Z","steps":["trace[2090786708] 'read index received' (duration: 183.514412ms)","trace[2090786708] 'applied index is now lower than readState.Index' (duration: 3.256073ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:23:49.211841Z","caller":"traceutil/trace.go:171","msg":"trace[1889985183] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"187.315998ms","start":"2026-04-29T22:23:49.024477Z","end":"2026-04-29T22:23:49.211793Z","steps":["trace[1889985183] 'process raft request' (duration: 183.81205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:23:49.211945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.216085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T22:23:49.212019Z","caller":"traceutil/trace.go:171","msg":"trace[353688021] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:5; }","duration":"187.347398ms","start":"2026-04-29T22:23:49.024658Z","end":"2026-04-29T22:23:49.212006Z","steps":["trace[353688021] 'agreement among raft nodes before linearized reading' (duration: 187.113093ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.217566Z","caller":"traceutil/trace.go:171","msg":"trace[1850622589] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"190.205051ms","start":"2026-04-29T22:23:49.027349Z","end":"2026-04-29T22:23:49.217554Z","steps":["trace[1850622589] 'process raft request' (duration: 190.022057ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.217568Z","caller":"traceutil/trace.go:171","msg":"trace[1213401123] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"190.059678ms","start":"2026-04-29T22:23:49.027459Z","end":"2026-04-29T22:23:49.217519Z","steps":["trace[1213401123] 'process raft request' (duration: 189.931116ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.21768Z","caller":"traceutil/trace.go:171","msg":"trace[1903059553] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"190.12347ms","start":"2026-04-29T22:23:49.027504Z","end":"2026-04-29T22:23:49.217628Z","steps":["trace[1903059553] 'process raft request' (duration: 189.907695ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.218013Z","caller":"traceutil/trace.go:171","msg":"trace[879479907] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"190.599843ms","start":"2026-04-29T22:23:49.027244Z","end":"2026-04-29T22:23:49.217844Z","steps":["trace[879479907] 'process raft request' (duration: 190.009049ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.218077Z","caller":"traceutil/trace.go:171","msg":"trace[382642331] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"190.127631ms","start":"2026-04-29T22:23:49.027313Z","end":"2026-04-29T22:23:49.217441Z","steps":["trace[382642331] 'process raft request' (duration: 190.030769ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.218872Z","caller":"traceutil/trace.go:171","msg":"trace[617541180] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"188.389572ms","start":"2026-04-29T22:23:49.03045Z","end":"2026-04-29T22:23:49.21884Z","steps":["trace[617541180] 'process raft request' (duration: 186.98719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:23:49.218924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.391754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T22:23:49.218996Z","caller":"traceutil/trace.go:171","msg":"trace[1890280017] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:0; response_revision:11; }","duration":"193.571848ms","start":"2026-04-29T22:23:49.025403Z","end":"2026-04-29T22:23:49.218975Z","steps":["trace[1890280017] 'agreement among raft nodes before linearized reading' (duration: 193.438525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:23:49.219076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.601003ms","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-04-29T22:23:49.219107Z","caller":"traceutil/trace.go:171","msg":"trace[2042175976] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"191.661335ms","start":"2026-04-29T22:23:49.027434Z","end":"2026-04-29T22:23:49.219096Z","steps":["trace[2042175976] 'agreement among raft nodes before linearized reading' (duration: 191.585904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:23:49.219211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.250102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-29T22:23:49.21922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.813998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-29T22:23:49.219235Z","caller":"traceutil/trace.go:171","msg":"trace[644901117] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"131.274832ms","start":"2026-04-29T22:23:49.087954Z","end":"2026-04-29T22:23:49.219229Z","steps":["trace[644901117] 'agreement among raft nodes before linearized reading' (duration: 131.240631ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:23:49.219242Z","caller":"traceutil/trace.go:171","msg":"trace[291713756] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"191.852789ms","start":"2026-04-29T22:23:49.027383Z","end":"2026-04-29T22:23:49.219235Z","steps":["trace[291713756] 'agreement among raft nodes before linearized reading' (duration: 191.811508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:23:49.219321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.103069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T22:23:49.219343Z","caller":"traceutil/trace.go:171","msg":"trace[983465754] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"148.1436ms","start":"2026-04-29T22:23:49.071194Z","end":"2026-04-29T22:23:49.219337Z","steps":["trace[983465754] 'agreement among raft nodes before linearized reading' (duration: 148.112769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:23:49.219361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.632607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-dsxtj\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-29T22:23:49.219379Z","caller":"traceutil/trace.go:171","msg":"trace[344983362] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-dsxtj; range_end:; response_count:1; response_revision:11; }","duration":"192.78072ms","start":"2026-04-29T22:23:49.026593Z","end":"2026-04-29T22:23:49.219373Z","steps":["trace[344983362] 'agreement among raft nodes before linearized reading' (duration: 192.734409ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.268278Z","caller":"traceutil/trace.go:171","msg":"trace[1416971379] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"124.391108ms","start":"2026-04-29T22:24:17.143865Z","end":"2026-04-29T22:24:17.268256Z","steps":["trace[1416971379] 'process raft request' (duration: 124.275936ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277056Z","caller":"traceutil/trace.go:171","msg":"trace[1950312676] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"128.99885ms","start":"2026-04-29T22:24:17.148022Z","end":"2026-04-29T22:24:17.277021Z","steps":["trace[1950312676] 'process raft request' (duration: 128.883378ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277219Z","caller":"traceutil/trace.go:171","msg":"trace[1956229458] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"119.731494ms","start":"2026-04-29T22:24:17.157479Z","end":"2026-04-29T22:24:17.277211Z","steps":["trace[1956229458] 'process raft request' (duration: 119.520229ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277285Z","caller":"traceutil/trace.go:171","msg":"trace[1565771256] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"121.916503ms","start":"2026-04-29T22:24:17.155363Z","end":"2026-04-29T22:24:17.277279Z","steps":["trace[1565771256] 'process raft request' (duration: 121.594446ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277359Z","caller":"traceutil/trace.go:171","msg":"trace[434137181] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"118.679161ms","start":"2026-04-29T22:24:17.158673Z","end":"2026-04-29T22:24:17.277352Z","steps":["trace[434137181] 'process raft request' (duration: 118.493237ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277417Z","caller":"traceutil/trace.go:171","msg":"trace[1057173435] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"119.883787ms","start":"2026-04-29T22:24:17.157528Z","end":"2026-04-29T22:24:17.277411Z","steps":["trace[1057173435] 'process raft request' (duration: 119.603351ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277557Z","caller":"traceutil/trace.go:171","msg":"trace[1925049473] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"117.230418ms","start":"2026-04-29T22:24:17.160292Z","end":"2026-04-29T22:24:17.277522Z","steps":["trace[1925049473] 'process raft request' (duration: 116.913021ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277631Z","caller":"traceutil/trace.go:171","msg":"trace[1814041642] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"112.560673ms","start":"2026-04-29T22:24:17.165059Z","end":"2026-04-29T22:24:17.27762Z","steps":["trace[1814041642] 'process raft request' (duration: 112.197075ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:17.277873Z","caller":"traceutil/trace.go:171","msg":"trace[1864041421] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"133.703907ms","start":"2026-04-29T22:24:17.144158Z","end":"2026-04-29T22:24:17.277862Z","steps":["trace[1864041421] 'process raft request' (duration: 132.200133ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:23.840747Z","caller":"traceutil/trace.go:171","msg":"trace[1800272031] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"163.144636ms","start":"2026-04-29T22:24:23.677572Z","end":"2026-04-29T22:24:23.840717Z","steps":["trace[1800272031] 'process raft request' (duration: 162.744147ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:24.193062Z","caller":"traceutil/trace.go:171","msg":"trace[976362069] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"319.44182ms","start":"2026-04-29T22:24:23.873594Z","end":"2026-04-29T22:24:24.193036Z","steps":["trace[976362069] 'read index received' (duration: 318.420447ms)","trace[976362069] 'applied index is now lower than readState.Index' (duration: 1.020203ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:24:24.19327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.654005ms","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-04-29T22:24:24.193309Z","caller":"traceutil/trace.go:171","msg":"trace[1627726338] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"319.760577ms","start":"2026-04-29T22:24:23.873536Z","end":"2026-04-29T22:24:24.193296Z","steps":["trace[1627726338] 'agreement among raft nodes before linearized reading' (duration: 319.592184ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:24.193256Z","caller":"traceutil/trace.go:171","msg":"trace[1945096642] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"382.686317ms","start":"2026-04-29T22:24:23.810506Z","end":"2026-04-29T22:24:24.193192Z","steps":["trace[1945096642] 'process raft request' (duration: 381.835577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:24:24.193357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:24:23.873511Z","time spent":"319.837519ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T22:24:24.194066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:24:23.810479Z","time spent":"382.946733ms","remote":"127.0.0.1:44926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T22:24:24.532227Z","caller":"traceutil/trace.go:171","msg":"trace[438878199] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"275.170028ms","start":"2026-04-29T22:24:24.257026Z","end":"2026-04-29T22:24:24.532196Z","steps":["trace[438878199] 'process raft request' (duration: 275.056065ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:25.016516Z","caller":"traceutil/trace.go:171","msg":"trace[1827255462] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"290.742275ms","start":"2026-04-29T22:24:24.725743Z","end":"2026-04-29T22:24:25.016485Z","steps":["trace[1827255462] 'read index received' (duration: 290.51544ms)","trace[1827255462] 'applied index is now lower than readState.Index' (duration: 224.875µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:24:25.016619Z","caller":"traceutil/trace.go:171","msg":"trace[330307063] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"457.425202ms","start":"2026-04-29T22:24:24.559157Z","end":"2026-04-29T22:24:25.016582Z","steps":["trace[330307063] 'process raft request' (duration: 457.132825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:24:25.016721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.954911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:24:25.016777Z","caller":"traceutil/trace.go:171","msg":"trace[1979393312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"291.084163ms","start":"2026-04-29T22:24:24.725677Z","end":"2026-04-29T22:24:25.016761Z","steps":["trace[1979393312] 'agreement among raft nodes before linearized reading' (duration: 290.94838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:24:25.016772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:24:24.559137Z","time spent":"457.578065ms","remote":"127.0.0.1:45012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T22:24:25.284922Z","caller":"traceutil/trace.go:171","msg":"trace[185534674] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"262.766159ms","start":"2026-04-29T22:24:25.022127Z","end":"2026-04-29T22:24:25.284893Z","steps":["trace[185534674] 'process raft request' (duration: 248.748415ms)","trace[185534674] 'compare' (duration: 13.883181ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:24:25.296734Z","caller":"traceutil/trace.go:171","msg":"trace[1114344303] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"270.651666ms","start":"2026-04-29T22:24:25.026054Z","end":"2026-04-29T22:24:25.296705Z","steps":["trace[1114344303] 'process raft request' (duration: 270.602144ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:25.29701Z","caller":"traceutil/trace.go:171","msg":"trace[319616562] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"272.023657ms","start":"2026-04-29T22:24:25.024955Z","end":"2026-04-29T22:24:25.296978Z","steps":["trace[319616562] 'process raft request' (duration: 271.636498ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:25.296992Z","caller":"traceutil/trace.go:171","msg":"trace[1179685276] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"274.498592ms","start":"2026-04-29T22:24:25.022221Z","end":"2026-04-29T22:24:25.29672Z","steps":["trace[1179685276] 'process raft request' (duration: 274.182214ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:38.437322Z","caller":"traceutil/trace.go:171","msg":"trace[189018378] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"128.583651ms","start":"2026-04-29T22:24:38.308721Z","end":"2026-04-29T22:24:38.437305Z","steps":["trace[189018378] 'process raft request' (duration: 128.482999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:24:41.245069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.293827ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T22:24:41.245204Z","caller":"traceutil/trace.go:171","msg":"trace[858564068] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:762; }","duration":"519.809033ms","start":"2026-04-29T22:24:40.725379Z","end":"2026-04-29T22:24:41.245188Z","steps":["trace[858564068] 'read index received' (duration: 311.017983ms)","trace[858564068] 'applied index is now lower than readState.Index' (duration: 208.78957ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:24:41.245287Z","caller":"traceutil/trace.go:171","msg":"trace[2006149302] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"533.865345ms","start":"2026-04-29T22:24:40.71141Z","end":"2026-04-29T22:24:41.245276Z","steps":["trace[2006149302] 'process raft request' (duration: 325.110306ms)","trace[2006149302] 'compare' (duration: 208.116593ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:24:41.245384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:24:40.711402Z","time spent":"533.928336ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:24:41.245513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.585715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lgfwm\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-29T22:24:41.245559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.188301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:24:41.245595Z","caller":"traceutil/trace.go:171","msg":"trace[1675927329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:737; }","duration":"520.259473ms","start":"2026-04-29T22:24:40.725325Z","end":"2026-04-29T22:24:41.245584Z","steps":["trace[1675927329] 'agreement among raft nodes before linearized reading' (duration: 520.199122ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:24:41.245604Z","caller":"traceutil/trace.go:171","msg":"trace[798024271] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lgfwm; range_end:; response_count:1; response_revision:737; }","duration":"482.723488ms","start":"2026-04-29T22:24:40.762862Z","end":"2026-04-29T22:24:41.245585Z","steps":["trace[798024271] 'agreement among raft nodes before linearized reading' (duration: 482.465992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:24:41.245627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:24:40.725305Z","time spent":"520.315365ms","remote":"127.0.0.1:44822","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-04-29T22:24:41.245649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:24:40.762848Z","time spent":"482.791879ms","remote":"127.0.0.1:45012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lgfwm\" "} {"level":"warn","ts":"2026-04-29T22:25:16.41335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.402618ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-04-29T22:25:16.413612Z","caller":"traceutil/trace.go:171","msg":"trace[1852314566] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:989; }","duration":"214.500955ms","start":"2026-04-29T22:25:16.199094Z","end":"2026-04-29T22:25:16.413595Z","steps":["trace[1852314566] 'read index received' (duration: 134.096147ms)","trace[1852314566] 'applied index is now lower than readState.Index' (duration: 80.403908ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:25:16.413685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.589697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:25:16.413709Z","caller":"traceutil/trace.go:171","msg":"trace[1106444396] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"322.523445ms","start":"2026-04-29T22:25:16.091175Z","end":"2026-04-29T22:25:16.413698Z","steps":["trace[1106444396] 'process raft request' (duration: 322.2933ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:25:16.413714Z","caller":"traceutil/trace.go:171","msg":"trace[2110656370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"214.660769ms","start":"2026-04-29T22:25:16.199042Z","end":"2026-04-29T22:25:16.413703Z","steps":["trace[2110656370] 'agreement among raft nodes before linearized reading' (duration: 214.609027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:16.413787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:25:16.091158Z","time spent":"322.585046ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:25:33.969179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.738318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T22:25:33.969282Z","caller":"traceutil/trace.go:171","msg":"trace[1473865437] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"125.693867ms","start":"2026-04-29T22:25:33.843573Z","end":"2026-04-29T22:25:33.969266Z","steps":["trace[1473865437] 'read index received' (duration: 24.798885ms)","trace[1473865437] 'applied index is now lower than readState.Index' (duration: 100.894062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:25:33.969395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.81744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-29T22:25:33.969428Z","caller":"traceutil/trace.go:171","msg":"trace[146777937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1014; }","duration":"125.851221ms","start":"2026-04-29T22:25:33.843568Z","end":"2026-04-29T22:25:33.969419Z","steps":["trace[146777937] 'agreement among raft nodes before linearized reading' (duration: 125.738848ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:25:33.969416Z","caller":"traceutil/trace.go:171","msg":"trace[1529819156] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"133.926522ms","start":"2026-04-29T22:25:33.835442Z","end":"2026-04-29T22:25:33.969369Z","steps":["trace[1529819156] 'process raft request' (duration: 32.919657ms)","trace[1529819156] 'compare' (duration: 100.590975ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:25:34.075768Z","caller":"traceutil/trace.go:171","msg":"trace[399940227] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"102.95032ms","start":"2026-04-29T22:25:33.972796Z","end":"2026-04-29T22:25:34.075746Z","steps":["trace[399940227] 'process raft request' (duration: 102.553551ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:25:41.697415Z","caller":"traceutil/trace.go:171","msg":"trace[1550050915] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"145.585427ms","start":"2026-04-29T22:25:41.551816Z","end":"2026-04-29T22:25:41.697401Z","steps":["trace[1550050915] 'process raft request' (duration: 145.27161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:41.6978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.266801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-29T22:25:41.698447Z","caller":"traceutil/trace.go:171","msg":"trace[1057390397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1038; }","duration":"123.974536ms","start":"2026-04-29T22:25:41.574436Z","end":"2026-04-29T22:25:41.698411Z","steps":["trace[1057390397] 'agreement among raft nodes before linearized reading' (duration: 123.138437ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:25:41.698564Z","caller":"traceutil/trace.go:171","msg":"trace[955005539] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1076; }","duration":"122.791169ms","start":"2026-04-29T22:25:41.574488Z","end":"2026-04-29T22:25:41.697279Z","steps":["trace[955005539] 'read index received' (duration: 122.528943ms)","trace[955005539] 'applied index is now lower than readState.Index' (duration: 261.096µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:25:43.177417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.396714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-29T22:25:43.17747Z","caller":"traceutil/trace.go:171","msg":"trace[2034146851] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1043; }","duration":"345.494856ms","start":"2026-04-29T22:25:42.831964Z","end":"2026-04-29T22:25:43.177459Z","steps":["trace[2034146851] 'count revisions from in-memory index tree' (duration: 345.321653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:43.177496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:25:42.831944Z","time spent":"345.546388ms","remote":"127.0.0.1:45012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":28,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-04-29T22:25:43.177414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.495513ms","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-04-29T22:25:43.177609Z","caller":"traceutil/trace.go:171","msg":"trace[2067318660] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1043; }","duration":"305.735828ms","start":"2026-04-29T22:25:42.871868Z","end":"2026-04-29T22:25:43.177604Z","steps":["trace[2067318660] 'range keys from in-memory index tree' (duration: 305.316208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:43.17763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:25:42.87185Z","time spent":"305.774149ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T22:25:58.072543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.249326ms","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-04-29T22:25:58.072614Z","caller":"traceutil/trace.go:171","msg":"trace[16792222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1141; }","duration":"724.365879ms","start":"2026-04-29T22:25:57.348229Z","end":"2026-04-29T22:25:58.072595Z","steps":["trace[16792222] 'range keys from in-memory index tree' (duration: 724.078152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:58.072651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:25:57.348214Z","time spent":"724.429441ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T22:25:58.072831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.27783525s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-29T22:25:58.072873Z","caller":"traceutil/trace.go:171","msg":"trace[1278894388] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1141; }","duration":"1.277918102s","start":"2026-04-29T22:25:56.794943Z","end":"2026-04-29T22:25:58.072861Z","steps":["trace[1278894388] 'count revisions from in-memory index tree' (duration: 1.277752408s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:58.072906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:25:56.794921Z","time spent":"1.277975883s","remote":"127.0.0.1:45108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":28,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-04-29T22:25:58.072952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.202146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:25:58.073007Z","caller":"traceutil/trace.go:171","msg":"trace[1867108271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1141; }","duration":"349.298699ms","start":"2026-04-29T22:25:57.723694Z","end":"2026-04-29T22:25:58.072993Z","steps":["trace[1867108271] 'range keys from in-memory index tree' (duration: 349.143285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:25:58.073018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.700553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-29T22:25:58.073035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:25:57.723677Z","time spent":"349.352551ms","remote":"127.0.0.1:44822","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-04-29T22:25:58.073052Z","caller":"traceutil/trace.go:171","msg":"trace[1813345670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1141; }","duration":"227.767905ms","start":"2026-04-29T22:25:57.845274Z","end":"2026-04-29T22:25:58.073042Z","steps":["trace[1813345670] 'range keys from in-memory index tree' (duration: 227.606201ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:14.025554Z","caller":"traceutil/trace.go:171","msg":"trace[1927627054] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"287.479212ms","start":"2026-04-29T22:26:13.738054Z","end":"2026-04-29T22:26:14.025534Z","steps":["trace[1927627054] 'process raft request' (duration: 287.37795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:14.901856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.490061ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T22:26:14.901962Z","caller":"traceutil/trace.go:171","msg":"trace[1782457497] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"696.703514ms","start":"2026-04-29T22:26:14.205239Z","end":"2026-04-29T22:26:14.901942Z","steps":["trace[1782457497] 'process raft request' (duration: 317.040419ms)","trace[1782457497] 'compare' (duration: 379.055172ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:26:14.902019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.20523Z","time spent":"696.762066ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:26:15.390007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.197917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T22:26:15.390329Z","caller":"traceutil/trace.go:171","msg":"trace[2082697215] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"1.18403971s","start":"2026-04-29T22:26:14.20627Z","end":"2026-04-29T22:26:15.39031Z","steps":["trace[2082697215] 'process raft request' (duration: 1.183922378s)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:15.390316Z","caller":"traceutil/trace.go:171","msg":"trace[1610932679] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"1.184515781s","start":"2026-04-29T22:26:14.205767Z","end":"2026-04-29T22:26:15.390283Z","steps":["trace[1610932679] 'process raft request' (duration: 1.019944315s)","trace[1610932679] 'compare' (duration: 163.892921ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:26:15.390405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.206259Z","time spent":"1.184111702s","remote":"127.0.0.1:44998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:26:15.390469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.205744Z","time spent":"1.184651183s","remote":"127.0.0.1:45108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T22:26:15.390593Z","caller":"traceutil/trace.go:171","msg":"trace[973556001] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"1.18225113s","start":"2026-04-29T22:26:14.208331Z","end":"2026-04-29T22:26:15.390582Z","steps":["trace[973556001] 'process raft request' (duration: 1.181930603s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:15.390642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.208325Z","time spent":"1.182289811s","remote":"127.0.0.1:45310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T22:26:15.390652Z","caller":"traceutil/trace.go:171","msg":"trace[654798492] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1258; }","duration":"1.180101691s","start":"2026-04-29T22:26:14.210523Z","end":"2026-04-29T22:26:15.390625Z","steps":["trace[654798492] 'read index received' (duration: 311.766252ms)","trace[654798492] 'applied index is now lower than readState.Index' (duration: 868.334439ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:26:15.390743Z","caller":"traceutil/trace.go:171","msg":"trace[1102041287] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"714.389085ms","start":"2026-04-29T22:26:14.676344Z","end":"2026-04-29T22:26:15.390733Z","steps":["trace[1102041287] 'process raft request' (duration: 714.181489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:15.390791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.67631Z","time spent":"714.455316ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:26:15.390918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.180359738s","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-04-29T22:26:15.390958Z","caller":"traceutil/trace.go:171","msg":"trace[673748788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1216; }","duration":"1.18045864s","start":"2026-04-29T22:26:14.210485Z","end":"2026-04-29T22:26:15.390944Z","steps":["trace[673748788] 'agreement among raft nodes before linearized reading' (duration: 1.180277156s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:15.390993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.210472Z","time spent":"1.180512621s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T22:26:15.390963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.166188048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-29T22:26:15.391089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.678949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-29T22:26:15.391116Z","caller":"traceutil/trace.go:171","msg":"trace[1107172402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"1.166381552s","start":"2026-04-29T22:26:14.224725Z","end":"2026-04-29T22:26:15.391107Z","steps":["trace[1107172402] 'agreement among raft nodes before linearized reading' (duration: 1.166079185s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:15.391145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.224715Z","time spent":"1.166422394s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-29T22:26:15.391148Z","caller":"traceutil/trace.go:171","msg":"trace[1404062332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"907.75415ms","start":"2026-04-29T22:26:14.48337Z","end":"2026-04-29T22:26:15.391125Z","steps":["trace[1404062332] 'agreement among raft nodes before linearized reading' (duration: 907.646888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:15.391198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.483349Z","time spent":"907.838723ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-29T22:26:15.391236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086293254s","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-04-29T22:26:15.391299Z","caller":"traceutil/trace.go:171","msg":"trace[189516991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"1.086398446s","start":"2026-04-29T22:26:14.304888Z","end":"2026-04-29T22:26:15.391287Z","steps":["trace[189516991] 'agreement among raft nodes before linearized reading' (duration: 1.086240032s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:15.391333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:14.304866Z","time spent":"1.086457357s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-29T22:26:15.570075Z","caller":"traceutil/trace.go:171","msg":"trace[476743088] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"168.806843ms","start":"2026-04-29T22:26:15.401246Z","end":"2026-04-29T22:26:15.570053Z","steps":["trace[476743088] 'process raft request' (duration: 168.766403ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:15.570616Z","caller":"traceutil/trace.go:171","msg":"trace[1493569274] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"170.140293ms","start":"2026-04-29T22:26:15.400458Z","end":"2026-04-29T22:26:15.570598Z","steps":["trace[1493569274] 'process raft request' (duration: 101.653295ms)","trace[1493569274] 'compare' (duration: 67.74367ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:26:15.570787Z","caller":"traceutil/trace.go:171","msg":"trace[2055649327] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"169.918878ms","start":"2026-04-29T22:26:15.400859Z","end":"2026-04-29T22:26:15.570777Z","steps":["trace[2055649327] 'process raft request' (duration: 169.116819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:17.201854Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880605843691909,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-29T22:26:17.238929Z","caller":"traceutil/trace.go:171","msg":"trace[558940490] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"537.843686ms","start":"2026-04-29T22:26:16.701063Z","end":"2026-04-29T22:26:17.238907Z","steps":["trace[558940490] 'read index received' (duration: 537.643592ms)","trace[558940490] 'applied index is now lower than readState.Index' (duration: 199.254µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:26:17.238974Z","caller":"traceutil/trace.go:171","msg":"trace[844002350] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"932.239854ms","start":"2026-04-29T22:26:16.306706Z","end":"2026-04-29T22:26:17.238946Z","steps":["trace[844002350] 'process raft request' (duration: 932.05064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:17.239106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:16.30669Z","time spent":"932.355306ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:26:17.239164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.98049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-29T22:26:17.239155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.062182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:26:17.239201Z","caller":"traceutil/trace.go:171","msg":"trace[908554704] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1222; }","duration":"333.102873ms","start":"2026-04-29T22:26:16.906087Z","end":"2026-04-29T22:26:17.23919Z","steps":["trace[908554704] 'agreement among raft nodes before linearized reading' (duration: 332.952799ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:17.239234Z","caller":"traceutil/trace.go:171","msg":"trace[1810394420] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1222; }","duration":"538.208765ms","start":"2026-04-29T22:26:16.701007Z","end":"2026-04-29T22:26:17.239216Z","steps":["trace[1810394420] 'agreement among raft nodes before linearized reading' (duration: 538.030821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:17.239242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:16.906071Z","time spent":"333.162705ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-29T22:26:17.239282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:16.700984Z","time spent":"538.289526ms","remote":"127.0.0.1:45074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-04-29T22:26:17.347993Z","caller":"traceutil/trace.go:171","msg":"trace[1248757557] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"104.619442ms","start":"2026-04-29T22:26:17.243337Z","end":"2026-04-29T22:26:17.347956Z","steps":["trace[1248757557] 'process raft request' (duration: 102.869283ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:17.7122Z","caller":"traceutil/trace.go:171","msg":"trace[1257190651] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"157.268952ms","start":"2026-04-29T22:26:17.554906Z","end":"2026-04-29T22:26:17.712175Z","steps":["trace[1257190651] 'process raft request' (duration: 157.082697ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:17.712371Z","caller":"traceutil/trace.go:171","msg":"trace[91737543] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1273; }","duration":"137.883623ms","start":"2026-04-29T22:26:17.574457Z","end":"2026-04-29T22:26:17.712341Z","steps":["trace[91737543] 'read index received' (duration: 62.791237ms)","trace[91737543] 'applied index is now lower than readState.Index' (duration: 75.090866ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:26:17.712458Z","caller":"traceutil/trace.go:171","msg":"trace[1068739846] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"156.997675ms","start":"2026-04-29T22:26:17.555443Z","end":"2026-04-29T22:26:17.71244Z","steps":["trace[1068739846] 'process raft request' (duration: 156.697789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:17.712628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.153419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-29T22:26:17.712661Z","caller":"traceutil/trace.go:171","msg":"trace[608855366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1228; }","duration":"138.233371ms","start":"2026-04-29T22:26:17.574418Z","end":"2026-04-29T22:26:17.712652Z","steps":["trace[608855366] 'agreement among raft nodes before linearized reading' (duration: 138.061667ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:17.760807Z","caller":"traceutil/trace.go:171","msg":"trace[1012503234] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"119.038209ms","start":"2026-04-29T22:26:17.641734Z","end":"2026-04-29T22:26:17.760772Z","steps":["trace[1012503234] 'process raft request' (duration: 118.875744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:17.761054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.262528ms","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-04-29T22:26:17.761195Z","caller":"traceutil/trace.go:171","msg":"trace[1266958586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1229; }","duration":"186.40985ms","start":"2026-04-29T22:26:17.574725Z","end":"2026-04-29T22:26:17.761135Z","steps":["trace[1266958586] 'agreement among raft nodes before linearized reading' (duration: 186.076233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:17.76107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.210496ms","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-04-29T22:26:17.761377Z","caller":"traceutil/trace.go:171","msg":"trace[1741330868] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1229; }","duration":"186.630185ms","start":"2026-04-29T22:26:17.574729Z","end":"2026-04-29T22:26:17.761359Z","steps":["trace[1741330868] 'agreement among raft nodes before linearized reading' (duration: 186.063002ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:17.887289Z","caller":"traceutil/trace.go:171","msg":"trace[1952298217] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"108.205505ms","start":"2026-04-29T22:26:17.77906Z","end":"2026-04-29T22:26:17.887266Z","steps":["trace[1952298217] 'process raft request' (duration: 108.103502ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:19.687642Z","caller":"traceutil/trace.go:171","msg":"trace[687852387] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"242.928876ms","start":"2026-04-29T22:26:19.444661Z","end":"2026-04-29T22:26:19.68759Z","steps":["trace[687852387] 'process raft request' (duration: 221.249837ms)","trace[687852387] 'compare' (duration: 21.562876ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:26:21.897735Z","caller":"traceutil/trace.go:171","msg":"trace[1873279864] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"104.398608ms","start":"2026-04-29T22:26:21.793312Z","end":"2026-04-29T22:26:21.89771Z","steps":["trace[1873279864] 'process raft request' (duration: 23.788068ms)","trace[1873279864] 'compare' (duration: 80.259372ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:26:30.042726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880605843692080,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-29T22:26:30.175567Z","caller":"traceutil/trace.go:171","msg":"trace[823154447] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"703.021067ms","start":"2026-04-29T22:26:29.472528Z","end":"2026-04-29T22:26:30.175549Z","steps":["trace[823154447] 'process raft request' (duration: 702.875444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.175697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.472485Z","time spent":"703.141699ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:26:30.957233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.161475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T22:26:30.957375Z","caller":"traceutil/trace.go:171","msg":"trace[1356352665] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1358; }","duration":"1.415304664s","start":"2026-04-29T22:26:29.542044Z","end":"2026-04-29T22:26:30.957348Z","steps":["trace[1356352665] 'read index received' (duration: 633.287962ms)","trace[1356352665] 'applied index is now lower than readState.Index' (duration: 782.014561ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:26:30.957485Z","caller":"traceutil/trace.go:171","msg":"trace[1327565981] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"1.187705644s","start":"2026-04-29T22:26:29.769761Z","end":"2026-04-29T22:26:30.957467Z","steps":["trace[1327565981] 'process raft request' (duration: 993.210802ms)","trace[1327565981] 'compare' (duration: 193.855548ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:26:30.957639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.769735Z","time spent":"1.187789015s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:26:30.957905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.415863247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-29T22:26:30.95796Z","caller":"traceutil/trace.go:171","msg":"trace[199815743] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1310; }","duration":"1.41595513s","start":"2026-04-29T22:26:29.541991Z","end":"2026-04-29T22:26:30.957946Z","steps":["trace[199815743] 'agreement among raft nodes before linearized reading' (duration: 1.415781315s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.958002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.541971Z","time spent":"1.416019791s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-29T22:26:30.958047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23354588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:26:30.958153Z","caller":"traceutil/trace.go:171","msg":"trace[379548621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"1.233761715s","start":"2026-04-29T22:26:29.724366Z","end":"2026-04-29T22:26:30.958127Z","steps":["trace[379548621] 'agreement among raft nodes before linearized reading' (duration: 1.233585301s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.958236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.724346Z","time spent":"1.233872517s","remote":"127.0.0.1:44822","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-04-29T22:26:30.958421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.078109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-04-29T22:26:30.958458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.29436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:26:30.958485Z","caller":"traceutil/trace.go:171","msg":"trace[302525733] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1310; }","duration":"142.174821ms","start":"2026-04-29T22:26:30.816293Z","end":"2026-04-29T22:26:30.958467Z","steps":["trace[302525733] 'agreement among raft nodes before linearized reading' (duration: 142.034998ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:30.958513Z","caller":"traceutil/trace.go:171","msg":"trace[1858477651] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1310; }","duration":"976.369212ms","start":"2026-04-29T22:26:29.982131Z","end":"2026-04-29T22:26:30.9585Z","steps":["trace[1858477651] 'agreement among raft nodes before linearized reading' (duration: 976.29242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.958416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.00461849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-29T22:26:30.958548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.982125Z","time spent":"976.415453ms","remote":"127.0.0.1:34936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-29T22:26:30.958599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006564764s","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-04-29T22:26:30.958621Z","caller":"traceutil/trace.go:171","msg":"trace[1329298792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1310; }","duration":"1.004812853s","start":"2026-04-29T22:26:29.953744Z","end":"2026-04-29T22:26:30.958557Z","steps":["trace[1329298792] 'agreement among raft nodes before linearized reading' (duration: 1.00421097s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.958977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016462137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T22:26:30.959036Z","caller":"traceutil/trace.go:171","msg":"trace[1690763012] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1310; }","duration":"1.016822075s","start":"2026-04-29T22:26:29.942202Z","end":"2026-04-29T22:26:30.959024Z","steps":["trace[1690763012] 'agreement among raft nodes before linearized reading' (duration: 1.016465507s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.959004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.953734Z","time spent":"1.005257124s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-29T22:26:30.959145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.942191Z","time spent":"1.016872026s","remote":"127.0.0.1:45034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-04-29T22:26:30.958777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144645822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-29T22:26:30.961337Z","caller":"traceutil/trace.go:171","msg":"trace[1050337915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1310; }","duration":"1.14720988s","start":"2026-04-29T22:26:29.814086Z","end":"2026-04-29T22:26:30.961296Z","steps":["trace[1050337915] 'agreement among raft nodes before linearized reading' (duration: 1.144638552s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.958881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.876527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-29T22:26:30.95891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030240128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-29T22:26:30.958647Z","caller":"traceutil/trace.go:171","msg":"trace[943149674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1310; }","duration":"1.006655686s","start":"2026-04-29T22:26:29.951978Z","end":"2026-04-29T22:26:30.958634Z","steps":["trace[943149674] 'agreement among raft nodes before linearized reading' (duration: 1.006486022s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.961642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.814065Z","time spent":"1.147550727s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-29T22:26:30.961736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.951966Z","time spent":"1.009706374s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-29T22:26:30.961901Z","caller":"traceutil/trace.go:171","msg":"trace[1163959541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1310; }","duration":"1.033272756s","start":"2026-04-29T22:26:29.928611Z","end":"2026-04-29T22:26:30.961884Z","steps":["trace[1163959541] 'agreement among raft nodes before linearized reading' (duration: 1.030135346s)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:26:30.961931Z","caller":"traceutil/trace.go:171","msg":"trace[1700860282] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1310; }","duration":"323.962056ms","start":"2026-04-29T22:26:30.637926Z","end":"2026-04-29T22:26:30.961888Z","steps":["trace[1700860282] 'agreement among raft nodes before linearized reading' (duration: 320.398766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:26:30.961978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:29.928594Z","time spent":"1.033370809s","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-29T22:26:30.962021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:26:30.637906Z","time spent":"324.09169ms","remote":"127.0.0.1:44860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"warn","ts":"2026-04-29T22:27:01.389779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.753263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T22:27:01.390017Z","caller":"traceutil/trace.go:171","msg":"trace[1004141993] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"171.765306ms","start":"2026-04-29T22:27:01.21819Z","end":"2026-04-29T22:27:01.389956Z","steps":["trace[1004141993] 'process raft request' (duration: 34.758047ms)","trace[1004141993] 'compare' (duration: 136.510187ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:27:01.390083Z","caller":"traceutil/trace.go:171","msg":"trace[1034062482] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"167.5533ms","start":"2026-04-29T22:27:01.222512Z","end":"2026-04-29T22:27:01.390065Z","steps":["trace[1034062482] 'process raft request' (duration: 167.506439ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:01.390117Z","caller":"traceutil/trace.go:171","msg":"trace[760882991] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"169.220477ms","start":"2026-04-29T22:27:01.220865Z","end":"2026-04-29T22:27:01.390085Z","steps":["trace[760882991] 'process raft request' (duration: 169.106575ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:01.390042Z","caller":"traceutil/trace.go:171","msg":"trace[1889390722] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"169.150496ms","start":"2026-04-29T22:27:01.220863Z","end":"2026-04-29T22:27:01.390013Z","steps":["trace[1889390722] 'process raft request' (duration: 169.049334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:27:17.428831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.334363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-04-29T22:27:17.428919Z","caller":"traceutil/trace.go:171","msg":"trace[74258740] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1523; }","duration":"151.476426ms","start":"2026-04-29T22:27:17.277419Z","end":"2026-04-29T22:27:17.428896Z","steps":["trace[74258740] 'range keys from in-memory index tree' (duration: 151.090897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:27:17.428954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.602243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-29T22:27:17.429046Z","caller":"traceutil/trace.go:171","msg":"trace[1586209828] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1523; }","duration":"122.743737ms","start":"2026-04-29T22:27:17.306285Z","end":"2026-04-29T22:27:17.429028Z","steps":["trace[1586209828] 'range keys from in-memory index tree' (duration: 122.369849ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:17.606439Z","caller":"traceutil/trace.go:171","msg":"trace[2014310388] linearizableReadLoop","detail":"{readStateIndex:1585; appliedIndex:1584; }","duration":"127.993345ms","start":"2026-04-29T22:27:17.478417Z","end":"2026-04-29T22:27:17.606411Z","steps":["trace[2014310388] 'read index received' (duration: 53.190093ms)","trace[2014310388] 'applied index is now lower than readState.Index' (duration: 74.801982ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:27:17.606576Z","caller":"traceutil/trace.go:171","msg":"trace[1921625773] transaction","detail":"{read_only:false; response_revision:1525; number_of_response:1; }","duration":"173.085475ms","start":"2026-04-29T22:27:17.433453Z","end":"2026-04-29T22:27:17.606538Z","steps":["trace[1921625773] 'process raft request' (duration: 98.204231ms)","trace[1921625773] 'compare' (duration: 74.640198ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:27:17.60692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.495016ms","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-04-29T22:27:17.606985Z","caller":"traceutil/trace.go:171","msg":"trace[78428452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1525; }","duration":"128.622579ms","start":"2026-04-29T22:27:17.478349Z","end":"2026-04-29T22:27:17.606971Z","steps":["trace[78428452] 'agreement among raft nodes before linearized reading' (duration: 128.262571ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:18.014055Z","caller":"traceutil/trace.go:171","msg":"trace[123532805] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"401.959362ms","start":"2026-04-29T22:27:17.611474Z","end":"2026-04-29T22:27:18.013433Z","steps":["trace[123532805] 'process raft request' (duration: 401.737737ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:18.014112Z","caller":"traceutil/trace.go:171","msg":"trace[1532666881] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"402.521084ms","start":"2026-04-29T22:27:17.611561Z","end":"2026-04-29T22:27:18.014082Z","steps":["trace[1532666881] 'process raft request' (duration: 401.820059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:27:18.014235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:27:17.611436Z","time spent":"402.700158ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T22:27:18.014333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:27:17.611513Z","time spent":"402.709148ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T22:27:18.014424Z","caller":"traceutil/trace.go:171","msg":"trace[1264778307] transaction","detail":"{read_only:false; response_revision:1528; number_of_response:1; }","duration":"401.946722ms","start":"2026-04-29T22:27:17.61153Z","end":"2026-04-29T22:27:18.013477Z","steps":["trace[1264778307] 'process raft request' (duration: 401.815479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T22:27:18.01471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T22:27:17.611502Z","time spent":"403.122577ms","remote":"127.0.0.1:45092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T22:27:30.234713Z","caller":"traceutil/trace.go:171","msg":"trace[1470667154] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"109.733222ms","start":"2026-04-29T22:27:30.12495Z","end":"2026-04-29T22:27:30.234683Z","steps":["trace[1470667154] 'process raft request' (duration: 109.65953ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:30.234829Z","caller":"traceutil/trace.go:171","msg":"trace[1026216665] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"111.423609ms","start":"2026-04-29T22:27:30.123377Z","end":"2026-04-29T22:27:30.2348Z","steps":["trace[1026216665] 'process raft request' (duration: 62.876001ms)","trace[1026216665] 'compare' (duration: 48.091528ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:27:40.823404Z","caller":"traceutil/trace.go:171","msg":"trace[1910456208] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"117.175341ms","start":"2026-04-29T22:27:40.706186Z","end":"2026-04-29T22:27:40.823361Z","steps":["trace[1910456208] 'process raft request' (duration: 37.55692ms)","trace[1910456208] 'compare' (duration: 79.449787ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T22:27:55.943352Z","caller":"traceutil/trace.go:171","msg":"trace[1163924762] linearizableReadLoop","detail":"{readStateIndex:1767; appliedIndex:1766; }","duration":"117.831591ms","start":"2026-04-29T22:27:55.825495Z","end":"2026-04-29T22:27:55.943327Z","steps":["trace[1163924762] 'read index received' (duration: 117.679427ms)","trace[1163924762] 'applied index is now lower than readState.Index' (duration: 150.814µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T22:27:55.943514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.997974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-29T22:27:55.943597Z","caller":"traceutil/trace.go:171","msg":"trace[2090987173] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1700; }","duration":"118.136498ms","start":"2026-04-29T22:27:55.825448Z","end":"2026-04-29T22:27:55.943584Z","steps":["trace[2090987173] 'agreement among raft nodes before linearized reading' (duration: 117.975864ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:27:55.943556Z","caller":"traceutil/trace.go:171","msg":"trace[1247562192] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"124.298507ms","start":"2026-04-29T22:27:55.819222Z","end":"2026-04-29T22:27:55.94352Z","steps":["trace[1247562192] 'process raft request' (duration: 123.932938ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T22:29:06.722254Z","caller":"traceutil/trace.go:171","msg":"trace[1243981982] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"113.181594ms","start":"2026-04-29T22:29:06.609014Z","end":"2026-04-29T22:29:06.722196Z","steps":["trace[1243981982] 'process raft request' (duration: 112.828726ms)"],"step_count":1}