{"level":"warn","ts":"2026-04-07T00:14:15.692586Z","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-07T00:14:15.692809Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.42:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.42:2380","--initial-cluster=instance=https://199.19.213.42:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.42:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.42: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-07T00:14:15.69297Z","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-07T00:14:15.693021Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.42:2380"]} {"level":"info","ts":"2026-04-07T00:14:15.693064Z","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-07T00:14:15.694042Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.42:2379"]} {"level":"info","ts":"2026-04-07T00:14:15.694195Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.42:2380"],"listen-peer-urls":["https://199.19.213.42:2380"],"advertise-client-urls":["https://199.19.213.42:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.42:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.42: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-07T00:14:15.698275Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.749348ms"} {"level":"info","ts":"2026-04-07T00:14:15.704456Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eb9543883cdd7335","cluster-id":"54c72b3f8748f3c1"} {"level":"info","ts":"2026-04-07T00:14:15.704565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:14:15.704616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became follower at term 0"} {"level":"info","ts":"2026-04-07T00:14:15.704652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eb9543883cdd7335 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:14:15.704681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became follower at term 1"} {"level":"info","ts":"2026-04-07T00:14:15.70474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 switched to configuration voters=(16975548622858711861)"} {"level":"warn","ts":"2026-04-07T00:14:15.711693Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:14:15.713103Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:14:15.715217Z","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-07T00:14:15.721101Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eb9543883cdd7335","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:14:15.721754Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eb9543883cdd7335","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:14:15.72236Z","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-07T00:14:15.72251Z","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-07T00:14:15.722644Z","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-07T00:14:15.724621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 switched to configuration voters=(16975548622858711861)"} {"level":"info","ts":"2026-04-07T00:14:15.724792Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54c72b3f8748f3c1","local-member-id":"eb9543883cdd7335","added-peer-id":"eb9543883cdd7335","added-peer-peer-urls":["https://199.19.213.42:2380"]} {"level":"info","ts":"2026-04-07T00:14:15.729934Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.42:2380"} {"level":"info","ts":"2026-04-07T00:14:15.730145Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.42:2380"} {"level":"info","ts":"2026-04-07T00:14:15.729897Z","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-07T00:14:15.730474Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eb9543883cdd7335","initial-advertise-peer-urls":["https://199.19.213.42:2380"],"listen-peer-urls":["https://199.19.213.42:2380"],"advertise-client-urls":["https://199.19.213.42:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.42:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:14:15.73054Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:14:15.905633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:14:15.905706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:14:15.905747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 received MsgPreVoteResp from eb9543883cdd7335 at term 1"} {"level":"info","ts":"2026-04-07T00:14:15.905934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:14:15.905951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 received MsgVoteResp from eb9543883cdd7335 at term 2"} {"level":"info","ts":"2026-04-07T00:14:15.905963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb9543883cdd7335 became leader at term 2"} {"level":"info","ts":"2026-04-07T00:14:15.906055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eb9543883cdd7335 elected leader eb9543883cdd7335 at term 2"} {"level":"info","ts":"2026-04-07T00:14:15.908278Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eb9543883cdd7335","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.42:2379]}","request-path":"/0/members/eb9543883cdd7335/attributes","cluster-id":"54c72b3f8748f3c1","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:14:15.908472Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:14:15.908534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:14:15.908709Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:14:15.908922Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:14:15.908966Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:14:15.910874Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.42:2379"} {"level":"info","ts":"2026-04-07T00:14:15.912673Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:14:15.9128Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54c72b3f8748f3c1","local-member-id":"eb9543883cdd7335","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:14:15.912935Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:14:15.912996Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T00:14:18.964972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.140825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-07T00:14:18.965183Z","caller":"traceutil/trace.go:171","msg":"trace[1475554190] linearizableReadLoop","detail":"{readStateIndex:92; appliedIndex:91; }","duration":"311.8732ms","start":"2026-04-07T00:14:18.653288Z","end":"2026-04-07T00:14:18.965161Z","steps":["trace[1475554190] 'read index received' (duration: 32.841µs)","trace[1475554190] 'applied index is now lower than readState.Index' (duration: 311.838799ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:18.965404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.870221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:14:18.965383Z","caller":"traceutil/trace.go:171","msg":"trace[512636196] transaction","detail":"{read_only:false; response_revision:87; number_of_response:1; }","duration":"571.251791ms","start":"2026-04-07T00:14:18.394072Z","end":"2026-04-07T00:14:18.965324Z","steps":["trace[512636196] 'process raft request' (duration: 169.834602ms)","trace[512636196] 'compare' (duration: 399.98091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:18.965476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.664258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T00:14:18.965479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.169888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:14:18.965588Z","caller":"traceutil/trace.go:171","msg":"trace[1479297715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:87; }","duration":"200.838603ms","start":"2026-04-07T00:14:18.76473Z","end":"2026-04-07T00:14:18.965569Z","steps":["trace[1479297715] 'agreement among raft nodes before linearized reading' (duration: 200.617877ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:18.965451Z","caller":"traceutil/trace.go:171","msg":"trace[1331911641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:87; }","duration":"274.948823ms","start":"2026-04-07T00:14:18.690489Z","end":"2026-04-07T00:14:18.965438Z","steps":["trace[1331911641] 'agreement among raft nodes before linearized reading' (duration: 274.809408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:18.965737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:18.394062Z","time spent":"571.484366ms","remote":"127.0.0.1:36474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:14:18.965632Z","caller":"traceutil/trace.go:171","msg":"trace[1885199236] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:87; }","duration":"312.375563ms","start":"2026-04-07T00:14:18.653235Z","end":"2026-04-07T00:14:18.96561Z","steps":["trace[1885199236] 'agreement among raft nodes before linearized reading' (duration: 312.123586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:18.965871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:18.653217Z","time spent":"312.618678ms","remote":"127.0.0.1:36810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-04-07T00:14:18.966194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.858116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:14:18.966427Z","caller":"traceutil/trace.go:171","msg":"trace[1389580153] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:87; }","duration":"313.138793ms","start":"2026-04-07T00:14:18.653264Z","end":"2026-04-07T00:14:18.966403Z","steps":["trace[1389580153] 'agreement among raft nodes before linearized reading' (duration: 312.016833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:18.966593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:18.65325Z","time spent":"313.327777ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-04-07T00:14:19.261502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.0997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-07T00:14:19.261809Z","caller":"traceutil/trace.go:171","msg":"trace[2076414881] transaction","detail":"{read_only:false; response_revision:89; number_of_response:1; }","duration":"290.632987ms","start":"2026-04-07T00:14:18.971152Z","end":"2026-04-07T00:14:19.261785Z","steps":["trace[2076414881] 'process raft request' (duration: 290.516164ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:19.261833Z","caller":"traceutil/trace.go:171","msg":"trace[1229602562] linearizableReadLoop","detail":"{readStateIndex:93; appliedIndex:92; }","duration":"290.805453ms","start":"2026-04-07T00:14:18.970993Z","end":"2026-04-07T00:14:19.261799Z","steps":["trace[1229602562] 'read index received' (duration: 185.313362ms)","trace[1229602562] 'applied index is now lower than readState.Index' (duration: 105.48642ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:19.261982Z","caller":"traceutil/trace.go:171","msg":"trace[1290053568] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"291.572712ms","start":"2026-04-07T00:14:18.970172Z","end":"2026-04-07T00:14:19.261744Z","steps":["trace[1290053568] 'process raft request' (duration: 186.120373ms)","trace[1290053568] 'compare' (duration: 104.918345ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:19.262088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.066739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:14:19.262141Z","caller":"traceutil/trace.go:171","msg":"trace[162887319] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:89; }","duration":"291.156512ms","start":"2026-04-07T00:14:18.970977Z","end":"2026-04-07T00:14:19.262133Z","steps":["trace[162887319] 'agreement among raft nodes before linearized reading' (duration: 290.959606ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:48.063336Z","caller":"traceutil/trace.go:171","msg":"trace[913451102] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"121.309469ms","start":"2026-04-07T00:14:47.942002Z","end":"2026-04-07T00:14:48.063312Z","steps":["trace[913451102] 'process raft request' (duration: 71.518902ms)","trace[913451102] 'compare' (duration: 49.529099ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:53.517573Z","caller":"traceutil/trace.go:171","msg":"trace[818950342] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"117.03084ms","start":"2026-04-07T00:14:53.400512Z","end":"2026-04-07T00:14:53.517542Z","steps":["trace[818950342] 'process raft request' (duration: 115.818046ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.126823Z","caller":"traceutil/trace.go:171","msg":"trace[824880281] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"191.181394ms","start":"2026-04-07T00:14:53.935611Z","end":"2026-04-07T00:14:54.126792Z","steps":["trace[824880281] 'process raft request' (duration: 190.882956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.616659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.144774ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.616766Z","caller":"traceutil/trace.go:171","msg":"trace[512135340] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:625; }","duration":"209.262128ms","start":"2026-04-07T00:14:54.407487Z","end":"2026-04-07T00:14:54.616749Z","steps":["trace[512135340] 'range keys from in-memory index tree' (duration: 209.122073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.61751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.921521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:14:54.61758Z","caller":"traceutil/trace.go:171","msg":"trace[993305079] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"516.637558ms","start":"2026-04-07T00:14:54.100933Z","end":"2026-04-07T00:14:54.61757Z","steps":["trace[993305079] 'read index received' (duration: 25.602363ms)","trace[993305079] 'applied index is now lower than readState.Index' (duration: 491.034545ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:54.618067Z","caller":"traceutil/trace.go:171","msg":"trace[1237760595] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"621.328714ms","start":"2026-04-07T00:14:53.996724Z","end":"2026-04-07T00:14:54.618053Z","steps":["trace[1237760595] 'process raft request' (duration: 194.797915ms)","trace[1237760595] 'compare' (duration: 425.576512ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:54.618136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.203553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-07T00:14:54.618188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.443787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618194Z","caller":"traceutil/trace.go:171","msg":"trace[436375967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"517.317117ms","start":"2026-04-07T00:14:54.10086Z","end":"2026-04-07T00:14:54.618177Z","steps":["trace[436375967] 'agreement among raft nodes before linearized reading' (duration: 517.171013ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.618209Z","caller":"traceutil/trace.go:171","msg":"trace[1728442943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"165.463678ms","start":"2026-04-07T00:14:54.452738Z","end":"2026-04-07T00:14:54.618201Z","steps":["trace[1728442943] 'agreement among raft nodes before linearized reading' (duration: 165.434357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:54.10084Z","time spent":"517.380209ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T00:14:54.618236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:53.996701Z","time spent":"621.393456ms","remote":"127.0.0.1:36500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:14:54.618335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.652803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618356Z","caller":"traceutil/trace.go:171","msg":"trace[276881904] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"165.721285ms","start":"2026-04-07T00:14:54.452628Z","end":"2026-04-07T00:14:54.61835Z","steps":["trace[276881904] 'agreement among raft nodes before linearized reading' (duration: 165.690134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.550665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T00:14:54.618404Z","caller":"traceutil/trace.go:171","msg":"trace[1704983607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"382.838722ms","start":"2026-04-07T00:14:54.235556Z","end":"2026-04-07T00:14:54.618395Z","steps":["trace[1704983607] 'agreement among raft nodes before linearized reading' (duration: 382.504653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.107878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618432Z","caller":"traceutil/trace.go:171","msg":"trace[487149084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"263.120348ms","start":"2026-04-07T00:14:54.355305Z","end":"2026-04-07T00:14:54.618426Z","steps":["trace[487149084] 'agreement among raft nodes before linearized reading' (duration: 263.099067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:54.235536Z","time spent":"382.888263ms","remote":"127.0.0.1:36722","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-07T00:14:54.618554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.859967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618581Z","caller":"traceutil/trace.go:171","msg":"trace[796252754] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"138.899259ms","start":"2026-04-07T00:14:54.479674Z","end":"2026-04-07T00:14:54.618573Z","steps":["trace[796252754] 'agreement among raft nodes before linearized reading' (duration: 138.849907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.249588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618694Z","caller":"traceutil/trace.go:171","msg":"trace[1857885909] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"139.31479ms","start":"2026-04-07T00:14:54.47936Z","end":"2026-04-07T00:14:54.618675Z","steps":["trace[1857885909] 'agreement among raft nodes before linearized reading' (duration: 139.268199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.59284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618743Z","caller":"traceutil/trace.go:171","msg":"trace[1914485745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"138.62306ms","start":"2026-04-07T00:14:54.480096Z","end":"2026-04-07T00:14:54.618719Z","steps":["trace[1914485745] 'agreement among raft nodes before linearized reading' (duration: 138.59168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.810321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.618966Z","caller":"traceutil/trace.go:171","msg":"trace[364016316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"103.846742ms","start":"2026-04-07T00:14:54.515115Z","end":"2026-04-07T00:14:54.618961Z","steps":["trace[364016316] 'agreement among raft nodes before linearized reading' (duration: 103.812711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.618639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.031646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.619282Z","caller":"traceutil/trace.go:171","msg":"trace[1970050624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"165.770018ms","start":"2026-04-07T00:14:54.45345Z","end":"2026-04-07T00:14:54.61922Z","steps":["trace[1970050624] 'agreement among raft nodes before linearized reading' (duration: 164.707018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.619104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.854102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.619685Z","caller":"traceutil/trace.go:171","msg":"trace[1123790505] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"104.632654ms","start":"2026-04-07T00:14:54.515042Z","end":"2026-04-07T00:14:54.619674Z","steps":["trace[1123790505] 'agreement among raft nodes before linearized reading' (duration: 103.039869ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.824234Z","caller":"traceutil/trace.go:171","msg":"trace[522671005] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"199.516657ms","start":"2026-04-07T00:14:54.624689Z","end":"2026-04-07T00:14:54.824206Z","steps":["trace[522671005] 'process raft request' (duration: 194.500687ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.840383Z","caller":"traceutil/trace.go:171","msg":"trace[45375038] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:647; }","duration":"210.111402ms","start":"2026-04-07T00:14:54.630241Z","end":"2026-04-07T00:14:54.840352Z","steps":["trace[45375038] 'read index received' (duration: 188.87988ms)","trace[45375038] 'applied index is now lower than readState.Index' (duration: 21.230362ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:54.840768Z","caller":"traceutil/trace.go:171","msg":"trace[945558848] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"143.450585ms","start":"2026-04-07T00:14:54.697256Z","end":"2026-04-07T00:14:54.840707Z","steps":["trace[945558848] 'process raft request' (duration: 143.064265ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.840864Z","caller":"traceutil/trace.go:171","msg":"trace[537812955] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"215.831361ms","start":"2026-04-07T00:14:54.625001Z","end":"2026-04-07T00:14:54.840832Z","steps":["trace[537812955] 'process raft request' (duration: 215.158132ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.840836Z","caller":"traceutil/trace.go:171","msg":"trace[1644702204] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"215.744668ms","start":"2026-04-07T00:14:54.625061Z","end":"2026-04-07T00:14:54.840805Z","steps":["trace[1644702204] 'process raft request' (duration: 215.230144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.840929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.681187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:14:54.840807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.484762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.841101Z","caller":"traceutil/trace.go:171","msg":"trace[1454855313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:630; }","duration":"210.795901ms","start":"2026-04-07T00:14:54.630275Z","end":"2026-04-07T00:14:54.841071Z","steps":["trace[1454855313] 'agreement among raft nodes before linearized reading' (duration: 210.454471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.841349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.546829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.841394Z","caller":"traceutil/trace.go:171","msg":"trace[1365766692] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:630; }","duration":"105.602472ms","start":"2026-04-07T00:14:54.735777Z","end":"2026-04-07T00:14:54.84138Z","steps":["trace[1365766692] 'agreement among raft nodes before linearized reading' (duration: 105.54886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.8415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.711305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:14:54.840989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.539119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.841559Z","caller":"traceutil/trace.go:171","msg":"trace[2111982670] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:630; }","duration":"106.150757ms","start":"2026-04-07T00:14:54.735402Z","end":"2026-04-07T00:14:54.841552Z","steps":["trace[2111982670] 'agreement among raft nodes before linearized reading' (duration: 105.525599ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.84157Z","caller":"traceutil/trace.go:171","msg":"trace[440619010] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:630; }","duration":"156.792157ms","start":"2026-04-07T00:14:54.684758Z","end":"2026-04-07T00:14:54.84155Z","steps":["trace[440619010] 'agreement among raft nodes before linearized reading' (duration: 156.678834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.841588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.648083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:14:54.841343Z","caller":"traceutil/trace.go:171","msg":"trace[1945990466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:630; }","duration":"210.849222ms","start":"2026-04-07T00:14:54.630196Z","end":"2026-04-07T00:14:54.841045Z","steps":["trace[1945990466] 'agreement among raft nodes before linearized reading' (duration: 210.653047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.841716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.953001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.84176Z","caller":"traceutil/trace.go:171","msg":"trace[1714350700] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:630; }","duration":"157.003353ms","start":"2026-04-07T00:14:54.684741Z","end":"2026-04-07T00:14:54.841744Z","steps":["trace[1714350700] 'agreement among raft nodes before linearized reading' (duration: 156.93209ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:54.841636Z","caller":"traceutil/trace.go:171","msg":"trace[224523099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"132.723857ms","start":"2026-04-07T00:14:54.708898Z","end":"2026-04-07T00:14:54.841622Z","steps":["trace[224523099] 'agreement among raft nodes before linearized reading' (duration: 132.557532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.841909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.344162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.841964Z","caller":"traceutil/trace.go:171","msg":"trace[2135203822] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:630; }","duration":"157.429094ms","start":"2026-04-07T00:14:54.684521Z","end":"2026-04-07T00:14:54.84195Z","steps":["trace[2135203822] 'agreement among raft nodes before linearized reading' (duration: 157.347042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:54.842368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.095773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:54.842448Z","caller":"traceutil/trace.go:171","msg":"trace[875194152] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:630; }","duration":"107.200045ms","start":"2026-04-07T00:14:54.735216Z","end":"2026-04-07T00:14:54.842416Z","steps":["trace[875194152] 'agreement among raft nodes before linearized reading' (duration: 106.156866ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:15:10.216442Z","caller":"traceutil/trace.go:171","msg":"trace[473781891] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"149.558294ms","start":"2026-04-07T00:15:10.066859Z","end":"2026-04-07T00:15:10.216418Z","steps":["trace[473781891] 'read index received' (duration: 149.258386ms)","trace[473781891] 'applied index is now lower than readState.Index' (duration: 298.948µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:15:10.216578Z","caller":"traceutil/trace.go:171","msg":"trace[1623783611] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"183.920193ms","start":"2026-04-07T00:15:10.032594Z","end":"2026-04-07T00:15:10.216514Z","steps":["trace[1623783611] 'process raft request' (duration: 183.593964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:15:10.216733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.216324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T00:15:10.216781Z","caller":"traceutil/trace.go:171","msg":"trace[1269456168] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"145.342159ms","start":"2026-04-07T00:15:10.071428Z","end":"2026-04-07T00:15:10.21677Z","steps":["trace[1269456168] 'agreement among raft nodes before linearized reading' (duration: 145.131943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:15:10.216796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.922686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.42\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T00:15:10.216862Z","caller":"traceutil/trace.go:171","msg":"trace[1494522695] range","detail":"{range_begin:/registry/masterleases/199.19.213.42; range_end:; response_count:1; response_revision:785; }","duration":"149.999688ms","start":"2026-04-07T00:15:10.066842Z","end":"2026-04-07T00:15:10.216842Z","steps":["trace[1494522695] 'agreement among raft nodes before linearized reading' (duration: 149.719881ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:15:10.367826Z","caller":"traceutil/trace.go:171","msg":"trace[1253395784] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"145.461961ms","start":"2026-04-07T00:15:10.222337Z","end":"2026-04-07T00:15:10.367799Z","steps":["trace[1253395784] 'process raft request' (duration: 145.0803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:15:45.749174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.737098ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T00:15:45.749279Z","caller":"traceutil/trace.go:171","msg":"trace[498470401] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1040; }","duration":"393.762594ms","start":"2026-04-07T00:15:45.3555Z","end":"2026-04-07T00:15:45.749263Z","steps":["trace[498470401] 'read index received' (duration: 282.876002ms)","trace[498470401] 'applied index is now lower than readState.Index' (duration: 110.885232ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:15:45.749548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.040693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:15:45.74958Z","caller":"traceutil/trace.go:171","msg":"trace[1084778080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1006; }","duration":"394.122614ms","start":"2026-04-07T00:15:45.355447Z","end":"2026-04-07T00:15:45.74957Z","steps":["trace[1084778080] 'agreement among raft nodes before linearized reading' (duration: 394.049762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:15:45.749599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:45.355426Z","time spent":"394.168646ms","remote":"127.0.0.1:36402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T00:15:45.749626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.427439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:15:45.749705Z","caller":"traceutil/trace.go:171","msg":"trace[1350509695] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1006; }","duration":"322.572414ms","start":"2026-04-07T00:15:45.427117Z","end":"2026-04-07T00:15:45.749689Z","steps":["trace[1350509695] 'agreement among raft nodes before linearized reading' (duration: 322.43209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:15:45.749767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:15:45.427095Z","time spent":"322.646436ms","remote":"127.0.0.1:36752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-04-07T00:16:08.926858Z","caller":"traceutil/trace.go:171","msg":"trace[1634700782] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"179.202595ms","start":"2026-04-07T00:16:08.74763Z","end":"2026-04-07T00:16:08.926833Z","steps":["trace[1634700782] 'process raft request' (duration: 179.03734ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:09.574624Z","caller":"traceutil/trace.go:171","msg":"trace[1487879089] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"193.994229ms","start":"2026-04-07T00:16:09.380605Z","end":"2026-04-07T00:16:09.574599Z","steps":["trace[1487879089] 'process raft request' (duration: 193.957168ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:09.574825Z","caller":"traceutil/trace.go:171","msg":"trace[1871132579] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"305.138859ms","start":"2026-04-07T00:16:09.26957Z","end":"2026-04-07T00:16:09.574709Z","steps":["trace[1871132579] 'process raft request' (duration: 213.726327ms)","trace[1871132579] 'compare' (duration: 91.028231ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:09.57487Z","caller":"traceutil/trace.go:171","msg":"trace[1569445457] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"304.851891ms","start":"2026-04-07T00:16:09.270007Z","end":"2026-04-07T00:16:09.574859Z","steps":["trace[1569445457] 'process raft request' (duration: 304.509312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:09.574973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:09.269999Z","time spent":"304.900132ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:16:09.574987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:09.26955Z","time spent":"305.354135ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:16:10.35942Z","caller":"traceutil/trace.go:171","msg":"trace[1676722577] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1123; }","duration":"287.92686ms","start":"2026-04-07T00:16:10.071474Z","end":"2026-04-07T00:16:10.359401Z","steps":["trace[1676722577] 'read index received' (duration: 287.733174ms)","trace[1676722577] 'applied index is now lower than readState.Index' (duration: 191.516µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:10.359521Z","caller":"traceutil/trace.go:171","msg":"trace[559983769] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"307.456702ms","start":"2026-04-07T00:16:10.052024Z","end":"2026-04-07T00:16:10.35948Z","steps":["trace[559983769] 'process raft request' (duration: 307.250747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:10.359682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.194916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.42\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T00:16:10.359751Z","caller":"traceutil/trace.go:171","msg":"trace[733384154] range","detail":"{range_begin:/registry/masterleases/199.19.213.42; range_end:; response_count:1; response_revision:1085; }","duration":"288.31364ms","start":"2026-04-07T00:16:10.07142Z","end":"2026-04-07T00:16:10.359734Z","steps":["trace[733384154] 'agreement among raft nodes before linearized reading' (duration: 288.085804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:10.359756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:10.052002Z","time spent":"307.620227ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:16:10.486634Z","caller":"traceutil/trace.go:171","msg":"trace[1682695873] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1124; }","duration":"125.743039ms","start":"2026-04-07T00:16:10.360867Z","end":"2026-04-07T00:16:10.48661Z","steps":["trace[1682695873] 'read index received' (duration: 68.687783ms)","trace[1682695873] 'applied index is now lower than readState.Index' (duration: 57.053876ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:16:10.486826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.935204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:16:10.486963Z","caller":"traceutil/trace.go:171","msg":"trace[1683055529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1085; }","duration":"126.093938ms","start":"2026-04-07T00:16:10.360846Z","end":"2026-04-07T00:16:10.48694Z","steps":["trace[1683055529] 'agreement among raft nodes before linearized reading' (duration: 125.903932ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:11.711623Z","caller":"traceutil/trace.go:171","msg":"trace[1117991554] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"128.050021ms","start":"2026-04-07T00:16:11.583553Z","end":"2026-04-07T00:16:11.711603Z","steps":["trace[1117991554] 'process raft request' (duration: 128.016259ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:11.711791Z","caller":"traceutil/trace.go:171","msg":"trace[1904178173] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"129.207412ms","start":"2026-04-07T00:16:11.582549Z","end":"2026-04-07T00:16:11.711757Z","steps":["trace[1904178173] 'process raft request' (duration: 128.912404ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:41.454796Z","caller":"traceutil/trace.go:171","msg":"trace[1197074735] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"268.314012ms","start":"2026-04-07T00:16:41.186463Z","end":"2026-04-07T00:16:41.454777Z","steps":["trace[1197074735] 'read index received' (duration: 268.099006ms)","trace[1197074735] 'applied index is now lower than readState.Index' (duration: 214.166µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:41.455067Z","caller":"traceutil/trace.go:171","msg":"trace[411531919] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"357.187901ms","start":"2026-04-07T00:16:41.09787Z","end":"2026-04-07T00:16:41.455058Z","steps":["trace[411531919] 'process raft request' (duration: 356.745378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:41.455144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:41.097846Z","time spent":"357.244512ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:16:41.455316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.859956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T00:16:41.45534Z","caller":"traceutil/trace.go:171","msg":"trace[336277345] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"268.919178ms","start":"2026-04-07T00:16:41.186415Z","end":"2026-04-07T00:16:41.455334Z","steps":["trace[336277345] 'agreement among raft nodes before linearized reading' (duration: 268.841305ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:41.572054Z","caller":"traceutil/trace.go:171","msg":"trace[366502393] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"107.684217ms","start":"2026-04-07T00:16:41.464343Z","end":"2026-04-07T00:16:41.572027Z","steps":["trace[366502393] 'process raft request' (duration: 107.254315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:42.363137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.377972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:16:42.363215Z","caller":"traceutil/trace.go:171","msg":"trace[1166126091] linearizableReadLoop","detail":"{readStateIndex:1311; appliedIndex:1310; }","duration":"444.567309ms","start":"2026-04-07T00:16:41.918635Z","end":"2026-04-07T00:16:42.363203Z","steps":["trace[1166126091] 'read index received' (duration: 189.058023ms)","trace[1166126091] 'applied index is now lower than readState.Index' (duration: 255.508556ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:42.363473Z","caller":"traceutil/trace.go:171","msg":"trace[969955370] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"447.502488ms","start":"2026-04-07T00:16:41.915938Z","end":"2026-04-07T00:16:42.36344Z","steps":["trace[969955370] 'process raft request' (duration: 191.758506ms)","trace[969955370] 'compare' (duration: 255.214078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:16:42.363616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:41.915917Z","time spent":"447.624501ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:16:42.363609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.96034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:16:42.363685Z","caller":"traceutil/trace.go:171","msg":"trace[1908062867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1263; }","duration":"445.053711ms","start":"2026-04-07T00:16:41.918617Z","end":"2026-04-07T00:16:42.363671Z","steps":["trace[1908062867] 'agreement among raft nodes before linearized reading' (duration: 444.810985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:42.36372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:41.918609Z","time spent":"445.104453ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T00:16:42.664309Z","caller":"traceutil/trace.go:171","msg":"trace[2072336124] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"296.466312ms","start":"2026-04-07T00:16:42.367811Z","end":"2026-04-07T00:16:42.664278Z","steps":["trace[2072336124] 'process raft request' (duration: 222.412723ms)","trace[2072336124] 'compare' (duration: 73.945086ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:55.255902Z","caller":"traceutil/trace.go:171","msg":"trace[982066301] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"130.279037ms","start":"2026-04-07T00:16:55.125588Z","end":"2026-04-07T00:16:55.255867Z","steps":["trace[982066301] 'process raft request' (duration: 129.934697ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:55.913023Z","caller":"traceutil/trace.go:171","msg":"trace[1886054367] linearizableReadLoop","detail":"{readStateIndex:1406; appliedIndex:1405; }","duration":"289.72418ms","start":"2026-04-07T00:16:55.623267Z","end":"2026-04-07T00:16:55.912991Z","steps":["trace[1886054367] 'read index received' (duration: 289.480663ms)","trace[1886054367] 'applied index is now lower than readState.Index' (duration: 241.717µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:55.913159Z","caller":"traceutil/trace.go:171","msg":"trace[484495900] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"304.059737ms","start":"2026-04-07T00:16:55.609036Z","end":"2026-04-07T00:16:55.913096Z","steps":["trace[484495900] 'process raft request' (duration: 303.740388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:55.913654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:55.609004Z","time spent":"304.560139ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:16:55.913937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.650344ms","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-07T00:16:55.914029Z","caller":"traceutil/trace.go:171","msg":"trace[2055409456] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1355; }","duration":"290.791208ms","start":"2026-04-07T00:16:55.623218Z","end":"2026-04-07T00:16:55.91401Z","steps":["trace[2055409456] 'agreement among raft nodes before linearized reading' (duration: 289.934565ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:55.942032Z","caller":"traceutil/trace.go:171","msg":"trace[2128588524] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"109.116945ms","start":"2026-04-07T00:16:55.832885Z","end":"2026-04-07T00:16:55.942002Z","steps":["trace[2128588524] 'process raft request' (duration: 108.904519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:55.94209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.135481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T00:16:55.942148Z","caller":"traceutil/trace.go:171","msg":"trace[1363921355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1356; }","duration":"290.250863ms","start":"2026-04-07T00:16:55.651884Z","end":"2026-04-07T00:16:55.942135Z","steps":["trace[1363921355] 'agreement among raft nodes before linearized reading' (duration: 290.051838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:55.94229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.372368ms","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:535"} {"level":"info","ts":"2026-04-07T00:16:55.942317Z","caller":"traceutil/trace.go:171","msg":"trace[1882122301] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1356; }","duration":"260.419518ms","start":"2026-04-07T00:16:55.681891Z","end":"2026-04-07T00:16:55.942311Z","steps":["trace[1882122301] 'agreement among raft nodes before linearized reading' (duration: 260.355916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:56.233534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.617281ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:16:56.233729Z","caller":"traceutil/trace.go:171","msg":"trace[2079062766] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1407; }","duration":"186.868653ms","start":"2026-04-07T00:16:56.046845Z","end":"2026-04-07T00:16:56.233714Z","steps":["trace[2079062766] 'read index received' (duration: 129.242358ms)","trace[2079062766] 'applied index is now lower than readState.Index' (duration: 57.625225ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:16:56.233818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.978847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T00:16:56.233858Z","caller":"traceutil/trace.go:171","msg":"trace[1650466988] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1359; }","duration":"187.070089ms","start":"2026-04-07T00:16:56.046776Z","end":"2026-04-07T00:16:56.233846Z","steps":["trace[1650466988] 'agreement among raft nodes before linearized reading' (duration: 186.988876ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:56.233923Z","caller":"traceutil/trace.go:171","msg":"trace[1417711743] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"316.212804ms","start":"2026-04-07T00:16:55.917637Z","end":"2026-04-07T00:16:56.23385Z","steps":["trace[1417711743] 'process raft request' (duration: 31.185391ms)","trace[1417711743] 'compare' (duration: 284.382335ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:16:56.234018Z","caller":"traceutil/trace.go:171","msg":"trace[1124909791] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"288.263891ms","start":"2026-04-07T00:16:55.945711Z","end":"2026-04-07T00:16:56.233975Z","steps":["trace[1124909791] 'process raft request' (duration: 287.916882ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:16:56.234065Z","caller":"traceutil/trace.go:171","msg":"trace[1015799359] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"287.889469ms","start":"2026-04-07T00:16:55.946164Z","end":"2026-04-07T00:16:56.234053Z","steps":["trace[1015799359] 'process raft request' (duration: 287.513899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:16:56.234197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:16:55.917613Z","time spent":"316.455761ms","remote":"127.0.0.1:36722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}