{"level":"warn","ts":"2026-04-23T01:34:53.666365Z","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-23T01:34:53.666448Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-23T01:34:53.666503Z","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-23T01:34:53.666513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-23T01:34:53.666531Z","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-23T01:34:53.66712Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-04-23T01:34:53.667189Z","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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-23T01:34:53.674257Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.835541ms"} {"level":"info","ts":"2026-04-23T01:34:53.683268Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-04-23T01:34:53.683341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T01:34:53.683361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-04-23T01:34:53.683368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T01:34:53.683377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-04-23T01:34:53.683405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-04-23T01:34:53.697783Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T01:34:53.699297Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T01:34:53.70112Z","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-23T01:34:53.70456Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T01:34:53.705197Z","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-23T01:34:53.705226Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T01:34:53.705265Z","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-23T01:34:53.705277Z","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-23T01:34:53.707348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-04-23T01:34:53.710139Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-23T01:34:53.711251Z","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-23T01:34:53.711362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-23T01:34:53.711411Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-23T01:34:53.711476Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T01:34:53.711503Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T01:34:54.684386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T01:34:54.684441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T01:34:54.684473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-04-23T01:34:54.684489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-04-23T01:34:54.684498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-23T01:34:54.684511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-04-23T01:34:54.684522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-23T01:34:54.685644Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T01:34:54.685676Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T01:34:54.685934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T01:34:54.686501Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T01:34:54.686548Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T01:34:54.6862Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T01:34:54.687661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T01:34:54.687767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T01:34:54.687813Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T01:34:54.687886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-04-23T01:34:54.689093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T01:34:56.181354Z","caller":"traceutil/trace.go:171","msg":"trace[2078577555] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"257.719775ms","start":"2026-04-23T01:34:55.923622Z","end":"2026-04-23T01:34:56.181341Z","steps":["trace[2078577555] 'read index received' (duration: 257.661003ms)","trace[2078577555] 'applied index is now lower than readState.Index' (duration: 55.932µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:34:56.181389Z","caller":"traceutil/trace.go:171","msg":"trace[542449281] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"259.001434ms","start":"2026-04-23T01:34:55.922367Z","end":"2026-04-23T01:34:56.181368Z","steps":["trace[542449281] 'process raft request' (duration: 258.833711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.181907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.220627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T01:34:56.181973Z","caller":"traceutil/trace.go:171","msg":"trace[1851433567] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"258.345549ms","start":"2026-04-23T01:34:55.923611Z","end":"2026-04-23T01:34:56.181956Z","steps":["trace[1851433567] 'agreement among raft nodes before linearized reading' (duration: 257.838698ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.660718Z","caller":"traceutil/trace.go:171","msg":"trace[1400711136] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:5; }","duration":"479.253037ms","start":"2026-04-23T01:34:56.181439Z","end":"2026-04-23T01:34:56.660692Z","steps":["trace[1400711136] 'read index received' (duration: 479.049443ms)","trace[1400711136] 'applied index is now lower than readState.Index' (duration: 202.674µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:34:56.660945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.114211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-23T01:34:56.660989Z","caller":"traceutil/trace.go:171","msg":"trace[1564480930] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9; }","duration":"735.177823ms","start":"2026-04-23T01:34:55.9258Z","end":"2026-04-23T01:34:56.660977Z","steps":["trace[1564480930] 'agreement among raft nodes before linearized reading' (duration: 735.012759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.661027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.925786Z","time spent":"735.232254ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-23T01:34:56.66118Z","caller":"traceutil/trace.go:171","msg":"trace[32903466] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"676.618294ms","start":"2026-04-23T01:34:55.984488Z","end":"2026-04-23T01:34:56.661107Z","steps":["trace[32903466] 'process raft request' (duration: 676.024811ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661195Z","caller":"traceutil/trace.go:171","msg":"trace[1764834332] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"676.43277ms","start":"2026-04-23T01:34:55.984733Z","end":"2026-04-23T01:34:56.661166Z","steps":["trace[1764834332] 'process raft request' (duration: 675.872908ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661271Z","caller":"traceutil/trace.go:171","msg":"trace[944338553] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"676.42384ms","start":"2026-04-23T01:34:55.984838Z","end":"2026-04-23T01:34:56.661261Z","steps":["trace[944338553] 'process raft request' (duration: 675.788526ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661299Z","caller":"traceutil/trace.go:171","msg":"trace[180508793] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"651.670121ms","start":"2026-04-23T01:34:56.009619Z","end":"2026-04-23T01:34:56.661289Z","steps":["trace[180508793] 'process raft request' (duration: 651.033587ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661245Z","caller":"traceutil/trace.go:171","msg":"trace[560359708] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"676.46907ms","start":"2026-04-23T01:34:55.984715Z","end":"2026-04-23T01:34:56.661184Z","steps":["trace[560359708] 'process raft request' (duration: 675.866687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.661353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.912042ms","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-23T01:34:56.66138Z","caller":"traceutil/trace.go:171","msg":"trace[222268951] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"598.956902ms","start":"2026-04-23T01:34:56.062415Z","end":"2026-04-23T01:34:56.661372Z","steps":["trace[222268951] 'agreement among raft nodes before linearized reading' (duration: 598.916761ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661319Z","caller":"traceutil/trace.go:171","msg":"trace[1841373931] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"676.703736ms","start":"2026-04-23T01:34:55.984605Z","end":"2026-04-23T01:34:56.661308Z","steps":["trace[1841373931] 'process raft request' (duration: 675.949189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.661404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.062399Z","time spent":"598.999234ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-23T01:34:56.661445Z","caller":"traceutil/trace.go:171","msg":"trace[1106084407] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"676.957011ms","start":"2026-04-23T01:34:55.98448Z","end":"2026-04-23T01:34:56.661437Z","steps":["trace[1106084407] 'process raft request' (duration: 675.933678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.661515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.371449ms","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-23T01:34:56.661542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.072255ms","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-23T01:34:56.661543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.533855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T01:34:56.661577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.446391ms","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-23T01:34:56.661569Z","caller":"traceutil/trace.go:171","msg":"trace[1358444640] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"682.124075ms","start":"2026-04-23T01:34:55.979437Z","end":"2026-04-23T01:34:56.661561Z","steps":["trace[1358444640] 'agreement among raft nodes before linearized reading' (duration: 682.085465ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661603Z","caller":"traceutil/trace.go:171","msg":"trace[232301554] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"612.496702ms","start":"2026-04-23T01:34:56.049099Z","end":"2026-04-23T01:34:56.661596Z","steps":["trace[232301554] 'agreement among raft nodes before linearized reading' (duration: 612.461371ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:56.661598Z","caller":"traceutil/trace.go:171","msg":"trace[31589818] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:0; response_revision:9; }","duration":"677.645527ms","start":"2026-04-23T01:34:55.983932Z","end":"2026-04-23T01:34:56.661577Z","steps":["trace[31589818] 'agreement among raft nodes before linearized reading' (duration: 677.514564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.66162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.97942Z","time spent":"682.194028ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-23T01:34:56.66163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.049084Z","time spent":"612.540793ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-23T01:34:56.661645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.983918Z","time spent":"677.717249ms","remote":"127.0.0.1:48168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"warn","ts":"2026-04-23T01:34:56.661709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.040982ms","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-23T01:34:56.661745Z","caller":"traceutil/trace.go:171","msg":"trace[916461225] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"676.092962ms","start":"2026-04-23T01:34:55.985634Z","end":"2026-04-23T01:34:56.661727Z","steps":["trace[916461225] 'agreement among raft nodes before linearized reading' (duration: 676.056231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.661731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984465Z","time spent":"676.776607ms","remote":"127.0.0.1:48608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:56.661771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.985621Z","time spent":"676.143584ms","remote":"127.0.0.1:48240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-04-23T01:34:56.66154Z","caller":"traceutil/trace.go:171","msg":"trace[286550486] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"626.452002ms","start":"2026-04-23T01:34:56.03508Z","end":"2026-04-23T01:34:56.661532Z","steps":["trace[286550486] 'agreement among raft nodes before linearized reading' (duration: 626.401871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.66177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.144135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T01:34:56.661862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.035064Z","time spent":"626.791539ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-23T01:34:56.661923Z","caller":"traceutil/trace.go:171","msg":"trace[21632754] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"727.305538ms","start":"2026-04-23T01:34:55.934603Z","end":"2026-04-23T01:34:56.661909Z","steps":["trace[21632754] 'agreement among raft nodes before linearized reading' (duration: 727.147275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.661953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.934592Z","time spent":"727.353569ms","remote":"127.0.0.1:48544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-23T01:34:56.662059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984716Z","time spent":"676.530202ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:56.662139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.30986ms","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-23T01:34:56.662196Z","caller":"traceutil/trace.go:171","msg":"trace[237483146] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"677.376032ms","start":"2026-04-23T01:34:55.984795Z","end":"2026-04-23T01:34:56.662171Z","steps":["trace[237483146] 'agreement among raft nodes before linearized reading' (duration: 677.31131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:56.662232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984787Z","time spent":"677.433713ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-23T01:34:56.662269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984812Z","time spent":"676.477251ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:56.662484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.009601Z","time spent":"651.724271ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:56.665641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984595Z","time spent":"676.830288ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:56.665833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984456Z","time spent":"677.016823ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:56.668236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:55.984701Z","time spent":"676.679395ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:57.372208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.096508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-23T01:34:57.372615Z","caller":"traceutil/trace.go:171","msg":"trace[1710817950] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.189931028s","start":"2026-04-23T01:34:56.182634Z","end":"2026-04-23T01:34:57.372565Z","steps":["trace[1710817950] 'process raft request' (duration: 580.110584ms)","trace[1710817950] 'compare' (duration: 608.928034ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:34:57.372846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.182622Z","time spent":"1.190078741s","remote":"127.0.0.1:48212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:34:57.372951Z","caller":"traceutil/trace.go:171","msg":"trace[1176093017] transaction","detail":"{read_only:false; number_of_response:0; response_revision:11; }","duration":"704.038203ms","start":"2026-04-23T01:34:56.668886Z","end":"2026-04-23T01:34:57.372924Z","steps":["trace[1176093017] 'process raft request' (duration: 703.733246ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.37271Z","caller":"traceutil/trace.go:171","msg":"trace[1943627664] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:12; }","duration":"703.992761ms","start":"2026-04-23T01:34:56.668688Z","end":"2026-04-23T01:34:57.37268Z","steps":["trace[1943627664] 'read index received' (duration: 94.064845ms)","trace[1943627664] 'applied index is now lower than readState.Index' (duration: 609.924696ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:34:57.373085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.668882Z","time spent":"704.129764ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:57.373178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.474502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T01:34:57.373287Z","caller":"traceutil/trace.go:171","msg":"trace[1564608851] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"704.449411ms","start":"2026-04-23T01:34:56.668826Z","end":"2026-04-23T01:34:57.373276Z","steps":["trace[1564608851] 'process raft request' (duration: 703.722055ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.373304Z","caller":"traceutil/trace.go:171","msg":"trace[54644447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"704.604435ms","start":"2026-04-23T01:34:56.66866Z","end":"2026-04-23T01:34:57.373265Z","steps":["trace[54644447] 'agreement among raft nodes before linearized reading' (duration: 704.223237ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.373327Z","caller":"traceutil/trace.go:171","msg":"trace[2032249709] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"704.244517ms","start":"2026-04-23T01:34:56.66907Z","end":"2026-04-23T01:34:57.373314Z","steps":["trace[2032249709] 'process raft request' (duration: 703.572592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.373356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.668805Z","time spent":"704.517553ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:57.373346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.668645Z","time spent":"704.691927ms","remote":"127.0.0.1:48136","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-23T01:34:57.373395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.669062Z","time spent":"704.295648ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:34:57.373714Z","caller":"traceutil/trace.go:171","msg":"trace[1428368911] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"703.157193ms","start":"2026-04-23T01:34:56.670537Z","end":"2026-04-23T01:34:57.373694Z","steps":["trace[1428368911] 'process raft request' (duration: 703.045181ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.373661Z","caller":"traceutil/trace.go:171","msg":"trace[1556284062] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"703.948051ms","start":"2026-04-23T01:34:56.669702Z","end":"2026-04-23T01:34:57.37365Z","steps":["trace[1556284062] 'process raft request' (duration: 703.159633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.373823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.669693Z","time spent":"704.087244ms","remote":"127.0.0.1:48608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:57.373845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.670531Z","time spent":"703.234535ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:34:57.373867Z","caller":"traceutil/trace.go:171","msg":"trace[1405255983] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"702.974289ms","start":"2026-04-23T01:34:56.670871Z","end":"2026-04-23T01:34:57.373846Z","steps":["trace[1405255983] 'process raft request' (duration: 702.791255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.373933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.67085Z","time spent":"703.058311ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:34:57.374021Z","caller":"traceutil/trace.go:171","msg":"trace[2112754019] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"703.419129ms","start":"2026-04-23T01:34:56.670593Z","end":"2026-04-23T01:34:57.374012Z","steps":["trace[2112754019] 'process raft request' (duration: 703.032071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.374074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.670589Z","time spent":"703.46459ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:57.374144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.726145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T01:34:57.374179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.152933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T01:34:57.374197Z","caller":"traceutil/trace.go:171","msg":"trace[1442380155] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:18; }","duration":"491.795976ms","start":"2026-04-23T01:34:56.882388Z","end":"2026-04-23T01:34:57.374184Z","steps":["trace[1442380155] 'agreement among raft nodes before linearized reading' (duration: 491.666133ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.374211Z","caller":"traceutil/trace.go:171","msg":"trace[668085215] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:18; }","duration":"505.231184ms","start":"2026-04-23T01:34:56.868971Z","end":"2026-04-23T01:34:57.374202Z","steps":["trace[668085215] 'agreement among raft nodes before linearized reading' (duration: 505.169733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.374233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.882379Z","time spent":"491.847127ms","remote":"127.0.0.1:48520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-04-23T01:34:57.374246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.868938Z","time spent":"505.296446ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-04-23T01:34:57.374431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.624934ms","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-23T01:34:57.374469Z","caller":"traceutil/trace.go:171","msg":"trace[1994567158] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18; }","duration":"492.687446ms","start":"2026-04-23T01:34:56.881772Z","end":"2026-04-23T01:34:57.37446Z","steps":["trace[1994567158] 'agreement among raft nodes before linearized reading' (duration: 492.624085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.374497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.881762Z","time spent":"492.728707ms","remote":"127.0.0.1:48500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-04-23T01:34:57.374561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.197672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-23T01:34:57.374559Z","caller":"traceutil/trace.go:171","msg":"trace[1127920726] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"703.295706ms","start":"2026-04-23T01:34:56.67125Z","end":"2026-04-23T01:34:57.374545Z","steps":["trace[1127920726] 'process raft request' (duration: 702.435227ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.374626Z","caller":"traceutil/trace.go:171","msg":"trace[2060146416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"431.307214ms","start":"2026-04-23T01:34:56.943305Z","end":"2026-04-23T01:34:57.374613Z","steps":["trace[2060146416] 'agreement among raft nodes before linearized reading' (duration: 431.216482ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:34:57.374494Z","caller":"traceutil/trace.go:171","msg":"trace[215256874] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"699.200845ms","start":"2026-04-23T01:34:56.675278Z","end":"2026-04-23T01:34:57.374479Z","steps":["trace[215256874] 'process raft request' (duration: 698.436779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.374673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.943277Z","time spent":"431.386186ms","remote":"127.0.0.1:48124","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-23T01:34:57.3747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.675268Z","time spent":"699.400881ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:34:57.374695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.671229Z","time spent":"703.424249ms","remote":"127.0.0.1:48700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:34:57.374592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.903132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-04-23T01:34:57.374941Z","caller":"traceutil/trace.go:171","msg":"trace[22335543] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"705.411123ms","start":"2026-04-23T01:34:56.669511Z","end":"2026-04-23T01:34:57.374923Z","steps":["trace[22335543] 'agreement among raft nodes before linearized reading' (duration: 704.651947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.374959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.252081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-23T01:34:57.374978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.516111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-23T01:34:57.375281Z","caller":"traceutil/trace.go:171","msg":"trace[24386476] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:18; }","duration":"648.831638ms","start":"2026-04-23T01:34:56.726429Z","end":"2026-04-23T01:34:57.375261Z","steps":["trace[24386476] 'agreement among raft nodes before linearized reading' (duration: 648.4971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.375336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.726418Z","time spent":"648.90346ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-23T01:34:57.377382Z","caller":"traceutil/trace.go:171","msg":"trace[1472685839] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:18; }","duration":"657.689455ms","start":"2026-04-23T01:34:56.719664Z","end":"2026-04-23T01:34:57.377354Z","steps":["trace[1472685839] 'agreement among raft nodes before linearized reading' (duration: 655.265991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:34:57.377557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.719645Z","time spent":"657.879649ms","remote":"127.0.0.1:48258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-node-lease\" "} {"level":"warn","ts":"2026-04-23T01:34:57.380016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:34:56.669501Z","time spent":"710.494556ms","remote":"127.0.0.1:48324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-23T01:34:58.744475Z","caller":"traceutil/trace.go:171","msg":"trace[390855742] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"101.066521ms","start":"2026-04-23T01:34:58.643381Z","end":"2026-04-23T01:34:58.744447Z","steps":["trace[390855742] 'process raft request' (duration: 100.905537ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.345747Z","caller":"traceutil/trace.go:171","msg":"trace[1666011988] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"182.980439ms","start":"2026-04-23T01:35:24.162703Z","end":"2026-04-23T01:35:24.345683Z","steps":["trace[1666011988] 'process raft request' (duration: 182.769884ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.83267Z","caller":"traceutil/trace.go:171","msg":"trace[716650534] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"622.790491ms","start":"2026-04-23T01:35:24.209847Z","end":"2026-04-23T01:35:24.832638Z","steps":["trace[716650534] 'process raft request' (duration: 622.589936ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.832788Z","caller":"traceutil/trace.go:171","msg":"trace[2142867773] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"616.184965ms","start":"2026-04-23T01:35:24.216557Z","end":"2026-04-23T01:35:24.832742Z","steps":["trace[2142867773] 'process raft request' (duration: 616.007131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:24.832824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.209824Z","time spent":"622.928205ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:35:24.832936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.21655Z","time spent":"616.318507ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:24.832973Z","caller":"traceutil/trace.go:171","msg":"trace[31841031] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"606.564852ms","start":"2026-04-23T01:35:24.226396Z","end":"2026-04-23T01:35:24.832961Z","steps":["trace[31841031] 'process raft request' (duration: 606.303916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:24.833049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.226383Z","time spent":"606.636973ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:24.83311Z","caller":"traceutil/trace.go:171","msg":"trace[227710863] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"596.486368ms","start":"2026-04-23T01:35:24.236596Z","end":"2026-04-23T01:35:24.833082Z","steps":["trace[227710863] 'process raft request' (duration: 596.174891ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.833088Z","caller":"traceutil/trace.go:171","msg":"trace[558685833] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"616.361978ms","start":"2026-04-23T01:35:24.216679Z","end":"2026-04-23T01:35:24.833041Z","steps":["trace[558685833] 'process raft request' (duration: 615.935369ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.833129Z","caller":"traceutil/trace.go:171","msg":"trace[1688097485] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"596.472207ms","start":"2026-04-23T01:35:24.236648Z","end":"2026-04-23T01:35:24.83312Z","steps":["trace[1688097485] 'process raft request' (duration: 596.184181ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.833117Z","caller":"traceutil/trace.go:171","msg":"trace[1150001946] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"607.972212ms","start":"2026-04-23T01:35:24.225096Z","end":"2026-04-23T01:35:24.833068Z","steps":["trace[1150001946] 'process raft request' (duration: 607.566163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:24.833191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.236579Z","time spent":"596.56641ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:35:24.833211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.236644Z","time spent":"596.544668ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:35:24.833289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.216674Z","time spent":"616.538522ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:35:24.8333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.225068Z","time spent":"608.156046ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:24.833389Z","caller":"traceutil/trace.go:171","msg":"trace[1310375541] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"586.678751ms","start":"2026-04-23T01:35:24.246698Z","end":"2026-04-23T01:35:24.833377Z","steps":["trace[1310375541] 'process raft request' (duration: 586.2104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:24.833441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.246682Z","time spent":"586.734362ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:24.834018Z","caller":"traceutil/trace.go:171","msg":"trace[166207614] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"569.739784ms","start":"2026-04-23T01:35:24.264266Z","end":"2026-04-23T01:35:24.834006Z","steps":["trace[166207614] 'process raft request' (duration: 568.733912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:24.834089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.264247Z","time spent":"569.812755ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:24.834479Z","caller":"traceutil/trace.go:171","msg":"trace[1358724350] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"560.410147ms","start":"2026-04-23T01:35:24.274051Z","end":"2026-04-23T01:35:24.834461Z","steps":["trace[1358724350] 'process raft request' (duration: 560.172042ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:24.834449Z","caller":"traceutil/trace.go:171","msg":"trace[299422401] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"546.126001ms","start":"2026-04-23T01:35:24.288308Z","end":"2026-04-23T01:35:24.834434Z","steps":["trace[299422401] 'process raft request' (duration: 546.08028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:24.834555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.274034Z","time spent":"560.48725ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T01:35:24.834567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.288276Z","time spent":"546.258494ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:25.029377Z","caller":"traceutil/trace.go:171","msg":"trace[1502658570] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:489; }","duration":"518.948638ms","start":"2026-04-23T01:35:24.510404Z","end":"2026-04-23T01:35:25.029353Z","steps":["trace[1502658570] 'read index received' (duration: 322.116172ms)","trace[1502658570] 'applied index is now lower than readState.Index' (duration: 196.831506ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:35:25.029459Z","caller":"traceutil/trace.go:171","msg":"trace[1146009094] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"625.639365ms","start":"2026-04-23T01:35:24.403761Z","end":"2026-04-23T01:35:25.029401Z","steps":["trace[1146009094] 'process raft request' (duration: 569.885008ms)","trace[1146009094] 'compare' (duration: 55.516592ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:35:25.029611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.187214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T01:35:25.029669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.403706Z","time spent":"625.86374ms","remote":"127.0.0.1:48182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:35:25.029693Z","caller":"traceutil/trace.go:171","msg":"trace[859869039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"519.279946ms","start":"2026-04-23T01:35:24.510395Z","end":"2026-04-23T01:35:25.029675Z","steps":["trace[859869039] 'agreement among raft nodes before linearized reading' (duration: 519.083991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:25.029737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:24.510333Z","time spent":"519.396759ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T01:35:25.030072Z","caller":"traceutil/trace.go:171","msg":"trace[983257038] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"183.989791ms","start":"2026-04-23T01:35:24.846068Z","end":"2026-04-23T01:35:25.030058Z","steps":["trace[983257038] 'process raft request' (duration: 183.806797ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.030111Z","caller":"traceutil/trace.go:171","msg":"trace[882898109] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"183.742046ms","start":"2026-04-23T01:35:24.846339Z","end":"2026-04-23T01:35:25.030081Z","steps":["trace[882898109] 'process raft request' (duration: 183.579892ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.030166Z","caller":"traceutil/trace.go:171","msg":"trace[1018451000] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"184.000331ms","start":"2026-04-23T01:35:24.846047Z","end":"2026-04-23T01:35:25.030047Z","steps":["trace[1018451000] 'process raft request' (duration: 183.790986ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.031892Z","caller":"traceutil/trace.go:171","msg":"trace[1623278242] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"174.566982ms","start":"2026-04-23T01:35:24.857278Z","end":"2026-04-23T01:35:25.031845Z","steps":["trace[1623278242] 'process raft request' (duration: 172.970716ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.032423Z","caller":"traceutil/trace.go:171","msg":"trace[1686049214] transaction","detail":"{read_only:false; number_of_response:1; response_revision:487; }","duration":"184.926071ms","start":"2026-04-23T01:35:24.847477Z","end":"2026-04-23T01:35:25.032403Z","steps":["trace[1686049214] 'process raft request' (duration: 182.504567ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.030319Z","caller":"traceutil/trace.go:171","msg":"trace[1014037197] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"184.311148ms","start":"2026-04-23T01:35:24.845995Z","end":"2026-04-23T01:35:25.030307Z","steps":["trace[1014037197] 'process raft request' (duration: 183.757245ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.032699Z","caller":"traceutil/trace.go:171","msg":"trace[1050399659] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"180.717438ms","start":"2026-04-23T01:35:24.85185Z","end":"2026-04-23T01:35:25.032568Z","steps":["trace[1050399659] 'process raft request' (duration: 178.181702ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.0332Z","caller":"traceutil/trace.go:171","msg":"trace[1654181969] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"180.979003ms","start":"2026-04-23T01:35:24.852193Z","end":"2026-04-23T01:35:25.033171Z","steps":["trace[1654181969] 'process raft request' (duration: 177.888335ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.033459Z","caller":"traceutil/trace.go:171","msg":"trace[1317648632] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"180.919332ms","start":"2026-04-23T01:35:24.852415Z","end":"2026-04-23T01:35:25.033334Z","steps":["trace[1317648632] 'process raft request' (duration: 177.70464ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.034187Z","caller":"traceutil/trace.go:171","msg":"trace[1147500439] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"178.260843ms","start":"2026-04-23T01:35:24.855911Z","end":"2026-04-23T01:35:25.034171Z","steps":["trace[1147500439] 'process raft request' (duration: 174.255564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:25.036483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.016597ms","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-23T01:35:25.036539Z","caller":"traceutil/trace.go:171","msg":"trace[1908272279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:493; }","duration":"164.103449ms","start":"2026-04-23T01:35:24.872413Z","end":"2026-04-23T01:35:25.036516Z","steps":["trace[1908272279] 'agreement among raft nodes before linearized reading' (duration: 163.893024ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:25.036551Z","caller":"traceutil/trace.go:171","msg":"trace[566013144] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"176.254189ms","start":"2026-04-23T01:35:24.860268Z","end":"2026-04-23T01:35:25.036522Z","steps":["trace[566013144] 'process raft request' (duration: 171.28697ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:28.167955Z","caller":"traceutil/trace.go:171","msg":"trace[717648308] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"139.396742ms","start":"2026-04-23T01:35:28.028512Z","end":"2026-04-23T01:35:28.167909Z","steps":["trace[717648308] 'process raft request' (duration: 134.723478ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:30.830449Z","caller":"traceutil/trace.go:171","msg":"trace[129694508] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"653.738288ms","start":"2026-04-23T01:35:30.176685Z","end":"2026-04-23T01:35:30.830423Z","steps":["trace[129694508] 'process raft request' (duration: 653.543243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:30.830651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:30.176662Z","time spent":"653.883141ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:35:30.842845Z","caller":"traceutil/trace.go:171","msg":"trace[1983045929] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"514.012599ms","start":"2026-04-23T01:35:30.32882Z","end":"2026-04-23T01:35:30.842833Z","steps":["trace[1983045929] 'process raft request' (duration: 513.412386ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:30.842839Z","caller":"traceutil/trace.go:171","msg":"trace[1195230911] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:593; }","duration":"472.10573ms","start":"2026-04-23T01:35:30.370704Z","end":"2026-04-23T01:35:30.84281Z","steps":["trace[1195230911] 'read index received' (duration: 459.571782ms)","trace[1195230911] 'applied index is now lower than readState.Index' (duration: 12.529987ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:35:30.842925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:30.328787Z","time spent":"514.105771ms","remote":"127.0.0.1:48248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:35:30.843104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.377915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-23T01:35:30.843129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.98316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:35:30.843155Z","caller":"traceutil/trace.go:171","msg":"trace[1866169931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:572; }","duration":"472.496909ms","start":"2026-04-23T01:35:30.370644Z","end":"2026-04-23T01:35:30.843141Z","steps":["trace[1866169931] 'agreement among raft nodes before linearized reading' (duration: 472.323425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:30.843206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:30.37059Z","time spent":"472.606651ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T01:35:30.843205Z","caller":"traceutil/trace.go:171","msg":"trace[522518201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"331.109603ms","start":"2026-04-23T01:35:30.512076Z","end":"2026-04-23T01:35:30.843186Z","steps":["trace[522518201] 'agreement among raft nodes before linearized reading' (duration: 330.97741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:30.843248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:30.512061Z","time spent":"331.179144ms","remote":"127.0.0.1:48124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T01:35:31.42574Z","caller":"traceutil/trace.go:171","msg":"trace[409169003] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"249.8331ms","start":"2026-04-23T01:35:31.175858Z","end":"2026-04-23T01:35:31.425691Z","steps":["trace[409169003] 'process raft request' (duration: 248.991922ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:31.763204Z","caller":"traceutil/trace.go:171","msg":"trace[369990043] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"420.69882ms","start":"2026-04-23T01:35:31.342477Z","end":"2026-04-23T01:35:31.763176Z","steps":["trace[369990043] 'process raft request' (duration: 416.981337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:31.763368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:31.342455Z","time spent":"420.826593ms","remote":"127.0.0.1:48248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:35:33.092164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217599292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:35:33.092316Z","caller":"traceutil/trace.go:171","msg":"trace[672207131] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:583; }","duration":"1.217828217s","start":"2026-04-23T01:35:31.874454Z","end":"2026-04-23T01:35:33.092282Z","steps":["trace[672207131] 'range keys from in-memory index tree' (duration: 1.21750155s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:33.092412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.606662ms","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-23T01:35:33.092414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:31.874435Z","time spent":"1.217966199s","remote":"127.0.0.1:48384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-23T01:35:33.092448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.613182ms","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-23T01:35:33.092499Z","caller":"traceutil/trace.go:171","msg":"trace[17046013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"257.734705ms","start":"2026-04-23T01:35:32.834743Z","end":"2026-04-23T01:35:33.092477Z","steps":["trace[17046013] 'range keys from in-memory index tree' (duration: 257.428979ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:33.092543Z","caller":"traceutil/trace.go:171","msg":"trace[1171985760] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"238.785715ms","start":"2026-04-23T01:35:32.853736Z","end":"2026-04-23T01:35:33.092521Z","steps":["trace[1171985760] 'range keys from in-memory index tree' (duration: 238.326265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:33.092395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.727041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:35:33.092698Z","caller":"traceutil/trace.go:171","msg":"trace[1984848225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"582.102029ms","start":"2026-04-23T01:35:32.510556Z","end":"2026-04-23T01:35:33.092658Z","steps":["trace[1984848225] 'range keys from in-memory index tree' (duration: 581.642908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:33.092795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:32.510532Z","time spent":"582.224281ms","remote":"127.0.0.1:48124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T01:35:34.563168Z","caller":"traceutil/trace.go:171","msg":"trace[346758205] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"283.473747ms","start":"2026-04-23T01:35:34.279672Z","end":"2026-04-23T01:35:34.563146Z","steps":["trace[346758205] 'read index received' (duration: 283.275132ms)","trace[346758205] 'applied index is now lower than readState.Index' (duration: 197.725µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:35:34.563221Z","caller":"traceutil/trace.go:171","msg":"trace[1117182148] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"297.1601ms","start":"2026-04-23T01:35:34.266028Z","end":"2026-04-23T01:35:34.563188Z","steps":["trace[1117182148] 'process raft request' (duration: 296.920864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:34.563428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.054277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T01:35:34.563478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.780063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:35:34.563512Z","caller":"traceutil/trace.go:171","msg":"trace[1528438353] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:603; }","duration":"283.860484ms","start":"2026-04-23T01:35:34.279642Z","end":"2026-04-23T01:35:34.563503Z","steps":["trace[1528438353] 'agreement among raft nodes before linearized reading' (duration: 283.628999ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:34.563518Z","caller":"traceutil/trace.go:171","msg":"trace[1892607264] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:603; }","duration":"283.169219ms","start":"2026-04-23T01:35:34.280327Z","end":"2026-04-23T01:35:34.563496Z","steps":["trace[1892607264] 'agreement among raft nodes before linearized reading' (duration: 282.993715ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:45.421007Z","caller":"traceutil/trace.go:171","msg":"trace[751078008] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"202.407718ms","start":"2026-04-23T01:35:45.218574Z","end":"2026-04-23T01:35:45.420982Z","steps":["trace[751078008] 'process raft request' (duration: 103.133066ms)","trace[751078008] 'compare' (duration: 99.15904ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:35:47.754284Z","caller":"traceutil/trace.go:171","msg":"trace[1397359127] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:770; }","duration":"242.870446ms","start":"2026-04-23T01:35:47.511385Z","end":"2026-04-23T01:35:47.754256Z","steps":["trace[1397359127] 'read index received' (duration: 242.638441ms)","trace[1397359127] 'applied index is now lower than readState.Index' (duration: 231.175µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:35:47.754373Z","caller":"traceutil/trace.go:171","msg":"trace[743759685] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"324.582468ms","start":"2026-04-23T01:35:47.429759Z","end":"2026-04-23T01:35:47.754342Z","steps":["trace[743759685] 'process raft request' (duration: 324.323112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:47.754415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.01201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:35:47.754453Z","caller":"traceutil/trace.go:171","msg":"trace[507212903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"243.095861ms","start":"2026-04-23T01:35:47.511347Z","end":"2026-04-23T01:35:47.754442Z","steps":["trace[507212903] 'agreement among raft nodes before linearized reading' (duration: 243.012729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:47.754554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:47.429731Z","time spent":"324.719031ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:35:48.405303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.57866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-23T01:35:48.405354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.513684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T01:35:48.405408Z","caller":"traceutil/trace.go:171","msg":"trace[265126928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"477.740844ms","start":"2026-04-23T01:35:47.927646Z","end":"2026-04-23T01:35:48.405386Z","steps":["trace[265126928] 'range keys from in-memory index tree' (duration: 477.386196ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:35:48.405446Z","caller":"traceutil/trace.go:171","msg":"trace[922529147] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:744; }","duration":"323.654177ms","start":"2026-04-23T01:35:48.081772Z","end":"2026-04-23T01:35:48.405426Z","steps":["trace[922529147] 'range keys from in-memory index tree' (duration: 323.31869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:35:48.40546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:47.927624Z","time spent":"477.825906ms","remote":"127.0.0.1:48416","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-23T01:35:48.405488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:35:48.081751Z","time spent":"323.728718ms","remote":"127.0.0.1:48168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"info","ts":"2026-04-23T01:35:48.411821Z","caller":"traceutil/trace.go:171","msg":"trace[1251734033] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"161.368939ms","start":"2026-04-23T01:35:48.250417Z","end":"2026-04-23T01:35:48.411786Z","steps":["trace[1251734033] 'process raft request' (duration: 161.229025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.081701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.059117ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-23T01:36:24.081782Z","caller":"traceutil/trace.go:171","msg":"trace[1415001690] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"737.007537ms","start":"2026-04-23T01:36:23.344761Z","end":"2026-04-23T01:36:24.081769Z","steps":["trace[1415001690] 'read index received' (duration: 105.890179ms)","trace[1415001690] 'applied index is now lower than readState.Index' (duration: 631.116328ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:36:24.081822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.089766ms","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-23T01:36:24.081976Z","caller":"traceutil/trace.go:171","msg":"trace[1193740233] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:964; }","duration":"190.251039ms","start":"2026-04-23T01:36:23.891713Z","end":"2026-04-23T01:36:24.081964Z","steps":["trace[1193740233] 'range keys from in-memory index tree' (duration: 190.080916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.082038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.252042ms","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-23T01:36:24.082126Z","caller":"traceutil/trace.go:171","msg":"trace[1054964272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:964; }","duration":"737.383276ms","start":"2026-04-23T01:36:23.344726Z","end":"2026-04-23T01:36:24.082109Z","steps":["trace[1054964272] 'agreement among raft nodes before linearized reading' (duration: 737.12653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.082215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:23.344712Z","time spent":"737.470537ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T01:36:24.082418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.076354ms","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-23T01:36:24.08249Z","caller":"traceutil/trace.go:171","msg":"trace[161904699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:965; }","duration":"735.174117ms","start":"2026-04-23T01:36:23.347297Z","end":"2026-04-23T01:36:24.082472Z","steps":["trace[161904699] 'agreement among raft nodes before linearized reading' (duration: 734.964952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.082531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:23.347284Z","time spent":"735.238948ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T01:36:24.082794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.745572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-23T01:36:24.082803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.447155ms","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-23T01:36:24.082804Z","caller":"traceutil/trace.go:171","msg":"trace[1571743188] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"660.009119ms","start":"2026-04-23T01:36:23.422767Z","end":"2026-04-23T01:36:24.082776Z","steps":["trace[1571743188] 'process raft request' (duration: 659.339145ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:36:24.082834Z","caller":"traceutil/trace.go:171","msg":"trace[450094656] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:965; }","duration":"388.833804ms","start":"2026-04-23T01:36:23.693989Z","end":"2026-04-23T01:36:24.082823Z","steps":["trace[450094656] 'agreement among raft nodes before linearized reading' (duration: 388.744112ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:36:24.08284Z","caller":"traceutil/trace.go:171","msg":"trace[1478921750] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:965; }","duration":"172.524747ms","start":"2026-04-23T01:36:23.910306Z","end":"2026-04-23T01:36:24.08283Z","steps":["trace[1478921750] 'agreement among raft nodes before linearized reading' (duration: 172.401415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.082875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:23.693965Z","time spent":"388.902486ms","remote":"127.0.0.1:48594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-23T01:36:24.082959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:23.422748Z","time spent":"660.119961ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:36:24.447016Z","caller":"traceutil/trace.go:171","msg":"trace[1113469344] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"361.477567ms","start":"2026-04-23T01:36:24.085505Z","end":"2026-04-23T01:36:24.446982Z","steps":["trace[1113469344] 'process raft request' (duration: 336.411891ms)","trace[1113469344] 'compare' (duration: 24.851061ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:36:24.447214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:24.08548Z","time spent":"361.639991ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:36:24.44724Z","caller":"traceutil/trace.go:171","msg":"trace[1400947313] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"361.574649ms","start":"2026-04-23T01:36:24.085649Z","end":"2026-04-23T01:36:24.447224Z","steps":["trace[1400947313] 'process raft request' (duration: 361.273152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.447336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:24.08563Z","time spent":"361.653181ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:36:24.447386Z","caller":"traceutil/trace.go:171","msg":"trace[403817578] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1002; }","duration":"202.91891ms","start":"2026-04-23T01:36:24.244442Z","end":"2026-04-23T01:36:24.447361Z","steps":["trace[403817578] 'read index received' (duration: 177.509337ms)","trace[403817578] 'applied index is now lower than readState.Index' (duration: 25.408173ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:36:24.447566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.114145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T01:36:24.447594Z","caller":"traceutil/trace.go:171","msg":"trace[662451655] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"360.983986ms","start":"2026-04-23T01:36:24.0866Z","end":"2026-04-23T01:36:24.447584Z","steps":["trace[662451655] 'process raft request' (duration: 360.548906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.44763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:36:24.086589Z","time spent":"361.021027ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:36:24.447623Z","caller":"traceutil/trace.go:171","msg":"trace[1572632753] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:968; }","duration":"203.217447ms","start":"2026-04-23T01:36:24.24438Z","end":"2026-04-23T01:36:24.447597Z","steps":["trace[1572632753] 'agreement among raft nodes before linearized reading' (duration: 203.068504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:24.690595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.897082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:36:24.690686Z","caller":"traceutil/trace.go:171","msg":"trace[595262532] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:968; }","duration":"140.035185ms","start":"2026-04-23T01:36:24.550631Z","end":"2026-04-23T01:36:24.690666Z","steps":["trace[595262532] 'count revisions from in-memory index tree' (duration: 139.812581ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:36:47.325257Z","caller":"traceutil/trace.go:171","msg":"trace[1106493997] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"171.686498ms","start":"2026-04-23T01:36:47.153545Z","end":"2026-04-23T01:36:47.325232Z","steps":["trace[1106493997] 'process raft request' (duration: 171.537335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:47.587801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.234938ms","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-23T01:36:47.587909Z","caller":"traceutil/trace.go:171","msg":"trace[1222494424] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1042; }","duration":"180.385912ms","start":"2026-04-23T01:36:47.407486Z","end":"2026-04-23T01:36:47.587872Z","steps":["trace[1222494424] 'count revisions from in-memory index tree' (duration: 180.149705ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:36:49.031408Z","caller":"traceutil/trace.go:171","msg":"trace[727380557] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"145.244152ms","start":"2026-04-23T01:36:48.885916Z","end":"2026-04-23T01:36:49.031161Z","steps":["trace[727380557] 'process raft request' (duration: 145.113699ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:36:49.44669Z","caller":"traceutil/trace.go:171","msg":"trace[1086572969] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"112.804412ms","start":"2026-04-23T01:36:49.333868Z","end":"2026-04-23T01:36:49.446673Z","steps":["trace[1086572969] 'process raft request' (duration: 112.69194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:36:49.635688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.319147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:36:49.635816Z","caller":"traceutil/trace.go:171","msg":"trace[140108217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1049; }","duration":"124.502732ms","start":"2026-04-23T01:36:49.511278Z","end":"2026-04-23T01:36:49.635781Z","steps":["trace[140108217] 'range keys from in-memory index tree' (duration: 124.068951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:02.906962Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291008471367107,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T01:37:03.070262Z","caller":"traceutil/trace.go:171","msg":"trace[150536358] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"872.387989ms","start":"2026-04-23T01:37:02.197853Z","end":"2026-04-23T01:37:03.070241Z","steps":["trace[150536358] 'process raft request' (duration: 872.235695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.070424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.197834Z","time spent":"872.515471ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:37:03.270408Z","caller":"traceutil/trace.go:171","msg":"trace[776475774] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"900.441042ms","start":"2026-04-23T01:37:02.369936Z","end":"2026-04-23T01:37:03.270377Z","steps":["trace[776475774] 'process raft request' (duration: 898.894048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.270561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.369912Z","time spent":"900.572175ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:37:03.270649Z","caller":"traceutil/trace.go:171","msg":"trace[1702320813] linearizableReadLoop","detail":"{readStateIndex:1188; appliedIndex:1186; }","duration":"864.097066ms","start":"2026-04-23T01:37:02.406528Z","end":"2026-04-23T01:37:03.270626Z","steps":["trace[1702320813] 'read index received' (duration: 663.634499ms)","trace[1702320813] 'applied index is now lower than readState.Index' (duration: 200.459107ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:37:03.272156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.014268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:03.272201Z","caller":"traceutil/trace.go:171","msg":"trace[2108838276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1142; }","duration":"761.1028ms","start":"2026-04-23T01:37:02.511085Z","end":"2026-04-23T01:37:03.272187Z","steps":["trace[2108838276] 'agreement among raft nodes before linearized reading' (duration: 761.014468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.272233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.511069Z","time spent":"761.155732ms","remote":"127.0.0.1:48124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T01:37:03.272236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.126286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:03.272272Z","caller":"traceutil/trace.go:171","msg":"trace[173518588] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1142; }","duration":"235.208076ms","start":"2026-04-23T01:37:03.037054Z","end":"2026-04-23T01:37:03.272263Z","steps":["trace[173518588] 'agreement among raft nodes before linearized reading' (duration: 235.142575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.2724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.838664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:03.272494Z","caller":"traceutil/trace.go:171","msg":"trace[1659599740] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1142; }","duration":"865.995067ms","start":"2026-04-23T01:37:02.406481Z","end":"2026-04-23T01:37:03.272476Z","steps":["trace[1659599740] 'agreement among raft nodes before linearized reading' (duration: 864.230459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.272514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.231083ms","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-23T01:37:03.272549Z","caller":"traceutil/trace.go:171","msg":"trace[59458723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1142; }","duration":"514.266374ms","start":"2026-04-23T01:37:02.758273Z","end":"2026-04-23T01:37:03.272539Z","steps":["trace[59458723] 'agreement among raft nodes before linearized reading' (duration: 514.152051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.272549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.406461Z","time spent":"866.077519ms","remote":"127.0.0.1:48280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-04-23T01:37:03.272586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.758238Z","time spent":"514.339895ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T01:37:03.272514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.202491ms","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-23T01:37:03.272752Z","caller":"traceutil/trace.go:171","msg":"trace[1104127402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1142; }","duration":"159.526439ms","start":"2026-04-23T01:37:03.113216Z","end":"2026-04-23T01:37:03.272742Z","steps":["trace[1104127402] 'agreement among raft nodes before linearized reading' (duration: 159.210671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.272803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.217769ms","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-23T01:37:03.272849Z","caller":"traceutil/trace.go:171","msg":"trace[1442653810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1142; }","duration":"567.302321ms","start":"2026-04-23T01:37:02.705538Z","end":"2026-04-23T01:37:03.27284Z","steps":["trace[1442653810] 'agreement among raft nodes before linearized reading' (duration: 567.202569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.272883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.705526Z","time spent":"567.348932ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T01:37:03.272721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.202966ms","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-23T01:37:03.272966Z","caller":"traceutil/trace.go:171","msg":"trace[1374096976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1142; }","duration":"635.485364ms","start":"2026-04-23T01:37:02.637466Z","end":"2026-04-23T01:37:03.272951Z","steps":["trace[1374096976] 'agreement among raft nodes before linearized reading' (duration: 635.196346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:03.273008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:02.637445Z","time spent":"635.550425ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T01:37:17.798184Z","caller":"traceutil/trace.go:171","msg":"trace[533957337] linearizableReadLoop","detail":"{readStateIndex:1257; appliedIndex:1256; }","duration":"226.00266ms","start":"2026-04-23T01:37:17.572153Z","end":"2026-04-23T01:37:17.798155Z","steps":["trace[533957337] 'read index received' (duration: 225.732174ms)","trace[533957337] 'applied index is now lower than readState.Index' (duration: 269.326µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:37:17.798925Z","caller":"traceutil/trace.go:171","msg":"trace[699684934] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"231.115003ms","start":"2026-04-23T01:37:17.567779Z","end":"2026-04-23T01:37:17.798894Z","steps":["trace[699684934] 'process raft request' (duration: 230.212853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:17.799113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.604411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:17.799186Z","caller":"traceutil/trace.go:171","msg":"trace[1307048553] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1208; }","duration":"202.737274ms","start":"2026-04-23T01:37:17.596428Z","end":"2026-04-23T01:37:17.799165Z","steps":["trace[1307048553] 'agreement among raft nodes before linearized reading' (duration: 202.614941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:17.799396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.218266ms","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-23T01:37:17.799467Z","caller":"traceutil/trace.go:171","msg":"trace[470630549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1208; }","duration":"227.323878ms","start":"2026-04-23T01:37:17.572125Z","end":"2026-04-23T01:37:17.799449Z","steps":["trace[470630549] 'agreement among raft nodes before linearized reading' (duration: 227.063742ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:19.646804Z","caller":"traceutil/trace.go:171","msg":"trace[899401822] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"264.881182ms","start":"2026-04-23T01:37:19.381898Z","end":"2026-04-23T01:37:19.646779Z","steps":["trace[899401822] 'read index received' (duration: 264.682006ms)","trace[899401822] 'applied index is now lower than readState.Index' (duration: 197.985µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:37:19.64689Z","caller":"traceutil/trace.go:171","msg":"trace[1768288607] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"327.012628ms","start":"2026-04-23T01:37:19.319853Z","end":"2026-04-23T01:37:19.646866Z","steps":["trace[1768288607] 'process raft request' (duration: 326.67529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:19.647012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:19.319826Z","time spent":"327.111621ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:37:19.647144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.247999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-23T01:37:19.64719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.865786ms","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-23T01:37:19.647222Z","caller":"traceutil/trace.go:171","msg":"trace[1213753457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1214; }","duration":"265.349212ms","start":"2026-04-23T01:37:19.381827Z","end":"2026-04-23T01:37:19.647177Z","steps":["trace[1213753457] 'agreement among raft nodes before linearized reading' (duration: 265.144508ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:19.647258Z","caller":"traceutil/trace.go:171","msg":"trace[766819081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1214; }","duration":"257.964628ms","start":"2026-04-23T01:37:19.389277Z","end":"2026-04-23T01:37:19.647241Z","steps":["trace[766819081] 'agreement among raft nodes before linearized reading' (duration: 257.754043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:19.647511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.444285ms","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-23T01:37:19.64758Z","caller":"traceutil/trace.go:171","msg":"trace[1308562405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1214; }","duration":"261.541338ms","start":"2026-04-23T01:37:19.386023Z","end":"2026-04-23T01:37:19.647565Z","steps":["trace[1308562405] 'agreement among raft nodes before linearized reading' (duration: 261.078418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:19.647839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.661522ms","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-23T01:37:19.64787Z","caller":"traceutil/trace.go:171","msg":"trace[1809869893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1214; }","duration":"262.731414ms","start":"2026-04-23T01:37:19.385129Z","end":"2026-04-23T01:37:19.64786Z","steps":["trace[1809869893] 'agreement among raft nodes before linearized reading' (duration: 261.897966ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:19.763824Z","caller":"traceutil/trace.go:171","msg":"trace[437343631] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"112.047503ms","start":"2026-04-23T01:37:19.651751Z","end":"2026-04-23T01:37:19.763799Z","steps":["trace[437343631] 'process raft request' (duration: 98.195476ms)","trace[437343631] 'compare' (duration: 13.733445ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:37:19.85987Z","caller":"traceutil/trace.go:171","msg":"trace[1463135705] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"205.443574ms","start":"2026-04-23T01:37:19.654378Z","end":"2026-04-23T01:37:19.859821Z","steps":["trace[1463135705] 'process raft request' (duration: 205.164607ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:19.859909Z","caller":"traceutil/trace.go:171","msg":"trace[281554231] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"205.444964ms","start":"2026-04-23T01:37:19.654446Z","end":"2026-04-23T01:37:19.859891Z","steps":["trace[281554231] 'process raft request' (duration: 205.122106ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:19.860105Z","caller":"traceutil/trace.go:171","msg":"trace[1801487412] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"206.213731ms","start":"2026-04-23T01:37:19.653881Z","end":"2026-04-23T01:37:19.860094Z","steps":["trace[1801487412] 'process raft request' (duration: 205.512425ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:19.981382Z","caller":"traceutil/trace.go:171","msg":"trace[1983928289] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"116.056082ms","start":"2026-04-23T01:37:19.865284Z","end":"2026-04-23T01:37:19.98134Z","steps":["trace[1983928289] 'process raft request' (duration: 29.290749ms)","trace[1983928289] 'compare' (duration: 86.61069ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:37:21.289501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291008471367280,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T01:37:21.514672Z","caller":"traceutil/trace.go:171","msg":"trace[465185786] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"807.520388ms","start":"2026-04-23T01:37:20.707134Z","end":"2026-04-23T01:37:21.514654Z","steps":["trace[465185786] 'process raft request' (duration: 807.405645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:21.514787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:20.70709Z","time spent":"807.64603ms","remote":"127.0.0.1:48228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T01:37:21.526981Z","caller":"traceutil/trace.go:171","msg":"trace[695669393] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1270; }","duration":"738.284874ms","start":"2026-04-23T01:37:20.788663Z","end":"2026-04-23T01:37:21.526948Z","steps":["trace[695669393] 'read index received' (duration: 725.889488ms)","trace[695669393] 'applied index is now lower than readState.Index' (duration: 12.393976ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:37:21.527339Z","caller":"traceutil/trace.go:171","msg":"trace[261936034] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"624.478901ms","start":"2026-04-23T01:37:20.902849Z","end":"2026-04-23T01:37:21.527328Z","steps":["trace[261936034] 'process raft request' (duration: 623.925199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:21.527463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:20.902819Z","time spent":"624.551503ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:37:21.527612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.955718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:21.527642Z","caller":"traceutil/trace.go:171","msg":"trace[883911205] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1222; }","duration":"739.02352ms","start":"2026-04-23T01:37:20.788611Z","end":"2026-04-23T01:37:21.527635Z","steps":["trace[883911205] 'agreement among raft nodes before linearized reading' (duration: 738.974599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:21.52767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:20.788591Z","time spent":"739.071411ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-23T01:37:21.794027Z","caller":"traceutil/trace.go:171","msg":"trace[2028893156] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"164.643239ms","start":"2026-04-23T01:37:21.629354Z","end":"2026-04-23T01:37:21.793997Z","steps":["trace[2028893156] 'process raft request' (duration: 164.037966ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:21.794224Z","caller":"traceutil/trace.go:171","msg":"trace[792514719] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"166.005309ms","start":"2026-04-23T01:37:21.628162Z","end":"2026-04-23T01:37:21.794168Z","steps":["trace[792514719] 'process raft request' (duration: 138.881138ms)","trace[792514719] 'compare' (duration: 26.201071ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:37:21.794046Z","caller":"traceutil/trace.go:171","msg":"trace[36468293] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"140.668178ms","start":"2026-04-23T01:37:21.653345Z","end":"2026-04-23T01:37:21.794013Z","steps":["trace[36468293] 'process raft request' (duration: 140.129006ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:23.923961Z","caller":"traceutil/trace.go:171","msg":"trace[1464292399] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1285; }","duration":"112.910502ms","start":"2026-04-23T01:37:23.811026Z","end":"2026-04-23T01:37:23.923936Z","steps":["trace[1464292399] 'read index received' (duration: 112.692708ms)","trace[1464292399] 'applied index is now lower than readState.Index' (duration: 216.254µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T01:37:23.924154Z","caller":"traceutil/trace.go:171","msg":"trace[231756353] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"123.742302ms","start":"2026-04-23T01:37:23.800366Z","end":"2026-04-23T01:37:23.924108Z","steps":["trace[231756353] 'process raft request' (duration: 123.390365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:23.924294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.253351ms","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-23T01:37:23.924769Z","caller":"traceutil/trace.go:171","msg":"trace[573801387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1235; }","duration":"113.683101ms","start":"2026-04-23T01:37:23.810958Z","end":"2026-04-23T01:37:23.924641Z","steps":["trace[573801387] 'agreement among raft nodes before linearized reading' (duration: 113.138618ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:26.921668Z","caller":"traceutil/trace.go:171","msg":"trace[1766910748] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"118.558827ms","start":"2026-04-23T01:37:26.803082Z","end":"2026-04-23T01:37:26.921641Z","steps":["trace[1766910748] 'process raft request' (duration: 118.397543ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:34.343026Z","caller":"traceutil/trace.go:171","msg":"trace[332651158] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"661.474192ms","start":"2026-04-23T01:37:33.681507Z","end":"2026-04-23T01:37:34.342981Z","steps":["trace[332651158] 'process raft request' (duration: 660.704054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.343179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:33.681491Z","time spent":"661.608194ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:37:34.810511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.499074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T01:37:34.810688Z","caller":"traceutil/trace.go:171","msg":"trace[1193061843] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"855.632235ms","start":"2026-04-23T01:37:33.955022Z","end":"2026-04-23T01:37:34.810654Z","steps":["trace[1193061843] 'process raft request' (duration: 723.909545ms)","trace[1193061843] 'compare' (duration: 131.248458ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:37:34.810851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.325906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T01:37:34.810893Z","caller":"traceutil/trace.go:171","msg":"trace[317478854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1310; }","duration":"794.409248ms","start":"2026-04-23T01:37:34.016475Z","end":"2026-04-23T01:37:34.810885Z","steps":["trace[317478854] 'agreement among raft nodes before linearized reading' (duration: 794.265544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.81093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.016459Z","time spent":"794.463919ms","remote":"127.0.0.1:48416","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":"info","ts":"2026-04-23T01:37:34.811053Z","caller":"traceutil/trace.go:171","msg":"trace[1278672423] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"807.15178ms","start":"2026-04-23T01:37:34.003893Z","end":"2026-04-23T01:37:34.811044Z","steps":["trace[1278672423] 'process raft request' (duration: 806.70499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.810841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:33.954989Z","time spent":"855.768358ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T01:37:34.811126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.003877Z","time spent":"807.220271ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T01:37:34.810715Z","caller":"traceutil/trace.go:171","msg":"trace[1429546910] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1360; }","duration":"794.143212ms","start":"2026-04-23T01:37:34.016524Z","end":"2026-04-23T01:37:34.810667Z","steps":["trace[1429546910] 'read index received' (duration: 325.671667ms)","trace[1429546910] 'applied index is now lower than readState.Index' (duration: 468.470615ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T01:37:34.811302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.721125ms","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-23T01:37:34.811334Z","caller":"traceutil/trace.go:171","msg":"trace[1255456561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1310; }","duration":"794.774766ms","start":"2026-04-23T01:37:34.016551Z","end":"2026-04-23T01:37:34.811326Z","steps":["trace[1255456561] 'agreement among raft nodes before linearized reading' (duration: 794.699775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.81136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.016539Z","time spent":"794.814797ms","remote":"127.0.0.1:48416","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-23T01:37:34.811387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.106464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T01:37:34.811426Z","caller":"traceutil/trace.go:171","msg":"trace[2037922428] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1310; }","duration":"721.170965ms","start":"2026-04-23T01:37:34.090245Z","end":"2026-04-23T01:37:34.811416Z","steps":["trace[2037922428] 'agreement among raft nodes before linearized reading' (duration: 721.060693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.811497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.090232Z","time spent":"721.257957ms","remote":"127.0.0.1:48354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":29,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-04-23T01:37:34.811489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.402351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:34.811545Z","caller":"traceutil/trace.go:171","msg":"trace[1582822165] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1310; }","duration":"103.465293ms","start":"2026-04-23T01:37:34.708065Z","end":"2026-04-23T01:37:34.81153Z","steps":["trace[1582822165] 'agreement among raft nodes before linearized reading' (duration: 103.33954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.811566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.245585ms","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-23T01:37:34.811593Z","caller":"traceutil/trace.go:171","msg":"trace[2046114977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1310; }","duration":"790.314187ms","start":"2026-04-23T01:37:34.02127Z","end":"2026-04-23T01:37:34.811585Z","steps":["trace[2046114977] 'agreement among raft nodes before linearized reading' (duration: 790.241435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.811617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.021249Z","time spent":"790.363498ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T01:37:34.811729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.900683ms","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-23T01:37:34.811744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.728455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:34.811758Z","caller":"traceutil/trace.go:171","msg":"trace[1619186257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1310; }","duration":"791.939023ms","start":"2026-04-23T01:37:34.019812Z","end":"2026-04-23T01:37:34.811751Z","steps":["trace[1619186257] 'agreement among raft nodes before linearized reading' (duration: 791.868552ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:37:34.811766Z","caller":"traceutil/trace.go:171","msg":"trace[1268468375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"794.747856ms","start":"2026-04-23T01:37:34.017011Z","end":"2026-04-23T01:37:34.811759Z","steps":["trace[1268468375] 'agreement among raft nodes before linearized reading' (duration: 794.718145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.811787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.016989Z","time spent":"794.794586ms","remote":"127.0.0.1:48124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T01:37:34.811622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.024883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:37:34.811818Z","caller":"traceutil/trace.go:171","msg":"trace[590154267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"301.255828ms","start":"2026-04-23T01:37:34.510555Z","end":"2026-04-23T01:37:34.81181Z","steps":["trace[590154267] 'agreement among raft nodes before linearized reading' (duration: 301.050403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.811847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.510535Z","time spent":"301.307118ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T01:37:34.811789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.019806Z","time spent":"791.976364ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T01:37:34.811491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.963692ms","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-23T01:37:34.811998Z","caller":"traceutil/trace.go:171","msg":"trace[1688894347] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1310; }","duration":"768.441362ms","start":"2026-04-23T01:37:34.043502Z","end":"2026-04-23T01:37:34.811943Z","steps":["trace[1688894347] 'agreement among raft nodes before linearized reading' (duration: 767.91189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T01:37:34.812109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T01:37:34.043492Z","time spent":"768.596995ms","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-23T01:40:40.614416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.288877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-23T01:40:40.614474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.87004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T01:40:40.614529Z","caller":"traceutil/trace.go:171","msg":"trace[240244085] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2189; }","duration":"187.508192ms","start":"2026-04-23T01:40:40.426997Z","end":"2026-04-23T01:40:40.614506Z","steps":["trace[240244085] 'count revisions from in-memory index tree' (duration: 187.170994ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T01:40:40.614529Z","caller":"traceutil/trace.go:171","msg":"trace[623947061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2189; }","duration":"101.958212ms","start":"2026-04-23T01:40:40.512552Z","end":"2026-04-23T01:40:40.61451Z","steps":["trace[623947061] 'range keys from in-memory index tree' (duration: 101.796598ms)"],"step_count":1}