{"level":"warn","ts":"2026-02-06T05:55:36.129649Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-06T05:55:36.129731Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.207: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://162.253.55.207:2380","--initial-cluster=instance=https://162.253.55.207:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.207:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.207: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-02-06T05:55:36.129793Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-06T05:55:36.129801Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.207:2380"]} {"level":"info","ts":"2026-02-06T05:55:36.129817Z","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-02-06T05:55:36.130845Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"]} {"level":"info","ts":"2026-02-06T05:55:36.13092Z","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":2,"max-cpu-available":2,"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://162.253.55.207:2380"],"listen-peer-urls":["https://162.253.55.207:2380"],"advertise-client-urls":["https://162.253.55.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.207: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-02-06T05:55:36.137528Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.527351ms"} {"level":"info","ts":"2026-02-06T05:55:36.153807Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6f1fcbe50562a63a","cluster-id":"a9b9f04f4e8a9fba"} {"level":"info","ts":"2026-02-06T05:55:36.153863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=()"} {"level":"info","ts":"2026-02-06T05:55:36.153882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 0"} {"level":"info","ts":"2026-02-06T05:55:36.153893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6f1fcbe50562a63a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-06T05:55:36.153901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 1"} {"level":"info","ts":"2026-02-06T05:55:36.153928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"} {"level":"warn","ts":"2026-02-06T05:55:36.170507Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-06T05:55:36.17481Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-06T05:55:36.178854Z","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-02-06T05:55:36.182884Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6f1fcbe50562a63a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-06T05:55:36.185317Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6f1fcbe50562a63a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-06T05:55:36.185449Z","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-02-06T05:55:36.18557Z","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-02-06T05:55:36.185621Z","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-02-06T05:55:36.185875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"} {"level":"info","ts":"2026-02-06T05:55:36.18604Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a9b9f04f4e8a9fba","local-member-id":"6f1fcbe50562a63a","added-peer-id":"6f1fcbe50562a63a","added-peer-peer-urls":["https://162.253.55.207:2380"]} {"level":"info","ts":"2026-02-06T05:55:36.207473Z","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-02-06T05:55:36.207753Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6f1fcbe50562a63a","initial-advertise-peer-urls":["https://162.253.55.207:2380"],"listen-peer-urls":["https://162.253.55.207:2380"],"advertise-client-urls":["https://162.253.55.207:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.207:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-06T05:55:36.207777Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-06T05:55:36.208006Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.207:2380"} {"level":"info","ts":"2026-02-06T05:55:36.208023Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.207:2380"} {"level":"info","ts":"2026-02-06T05:55:36.255981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a is starting a new election at term 1"} {"level":"info","ts":"2026-02-06T05:55:36.256005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became pre-candidate at term 1"} {"level":"info","ts":"2026-02-06T05:55:36.256016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgPreVoteResp from 6f1fcbe50562a63a at term 1"} {"level":"info","ts":"2026-02-06T05:55:36.256026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became candidate at term 2"} {"level":"info","ts":"2026-02-06T05:55:36.256089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgVoteResp from 6f1fcbe50562a63a at term 2"} {"level":"info","ts":"2026-02-06T05:55:36.256102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became leader at term 2"} {"level":"info","ts":"2026-02-06T05:55:36.256132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6f1fcbe50562a63a elected leader 6f1fcbe50562a63a at term 2"} {"level":"info","ts":"2026-02-06T05:55:36.258258Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6f1fcbe50562a63a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.207:2379]}","request-path":"/0/members/6f1fcbe50562a63a/attributes","cluster-id":"a9b9f04f4e8a9fba","publish-timeout":"7s"} {"level":"info","ts":"2026-02-06T05:55:36.25844Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:55:36.258522Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-06T05:55:36.258894Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-06T05:55:36.259874Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-06T05:55:36.25989Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-06T05:55:36.25992Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a9b9f04f4e8a9fba","local-member-id":"6f1fcbe50562a63a","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:55:36.259978Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:55:36.260013Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-06T05:55:36.262956Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-06T05:55:36.302817Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.207:2379"} {"level":"info","ts":"2026-02-06T05:55:51.054841Z","caller":"traceutil/trace.go:171","msg":"trace[1991791253] linearizableReadLoop","detail":"{readStateIndex:376; appliedIndex:375; }","duration":"242.518395ms","start":"2026-02-06T05:55:50.812306Z","end":"2026-02-06T05:55:51.054825Z","steps":["trace[1991791253] 'read index received' (duration: 242.35788ms)","trace[1991791253] 'applied index is now lower than readState.Index' (duration: 159.885µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:55:51.055061Z","caller":"traceutil/trace.go:171","msg":"trace[999991218] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"449.105579ms","start":"2026-02-06T05:55:50.605947Z","end":"2026-02-06T05:55:51.055053Z","steps":["trace[999991218] 'process raft request' (duration: 448.772119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:55:51.055665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:55:50.605928Z","time spent":"449.151821ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:55:51.055824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.515396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:55:51.055852Z","caller":"traceutil/trace.go:171","msg":"trace[1329175665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:367; }","duration":"243.580178ms","start":"2026-02-06T05:55:50.812264Z","end":"2026-02-06T05:55:51.055844Z","steps":["trace[1329175665] 'agreement among raft nodes before linearized reading' (duration: 243.532146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:55:51.056258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.790202ms","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-02-06T05:55:51.056291Z","caller":"traceutil/trace.go:171","msg":"trace[997360928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:367; }","duration":"219.843324ms","start":"2026-02-06T05:55:50.836439Z","end":"2026-02-06T05:55:51.056283Z","steps":["trace[997360928] 'agreement among raft nodes before linearized reading' (duration: 219.762112ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:55:51.419108Z","caller":"traceutil/trace.go:171","msg":"trace[1836576943] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"355.678202ms","start":"2026-02-06T05:55:51.063407Z","end":"2026-02-06T05:55:51.419086Z","steps":["trace[1836576943] 'process raft request' (duration: 355.644221ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:55:51.419262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:55:51.063384Z","time spent":"355.806436ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:55:51.419595Z","caller":"traceutil/trace.go:171","msg":"trace[762619057] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"357.100135ms","start":"2026-02-06T05:55:51.062484Z","end":"2026-02-06T05:55:51.419584Z","steps":["trace[762619057] 'process raft request' (duration: 356.317891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:55:51.41965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:55:51.062396Z","time spent":"357.224299ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:55:51.419792Z","caller":"traceutil/trace.go:171","msg":"trace[452775303] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"356.459076ms","start":"2026-02-06T05:55:51.063323Z","end":"2026-02-06T05:55:51.419782Z","steps":["trace[452775303] 'process raft request' (duration: 355.695493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:55:51.41984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:55:51.063316Z","time spent":"356.498837ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:55:57.238225Z","caller":"traceutil/trace.go:171","msg":"trace[952068567] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"161.558725ms","start":"2026-02-06T05:55:57.076648Z","end":"2026-02-06T05:55:57.238207Z","steps":["trace[952068567] 'process raft request' (duration: 161.435061ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:07.800212Z","caller":"traceutil/trace.go:171","msg":"trace[44474264] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:484; }","duration":"314.890298ms","start":"2026-02-06T05:56:07.485302Z","end":"2026-02-06T05:56:07.800193Z","steps":["trace[44474264] 'read index received' (duration: 314.764114ms)","trace[44474264] 'applied index is now lower than readState.Index' (duration: 125.374µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:56:07.800306Z","caller":"traceutil/trace.go:171","msg":"trace[561149389] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"523.048306ms","start":"2026-02-06T05:56:07.27725Z","end":"2026-02-06T05:56:07.800298Z","steps":["trace[561149389] 'process raft request' (duration: 522.83482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:07.8004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:07.277241Z","time spent":"523.096699ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:07.800476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.288963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:56:07.800527Z","caller":"traceutil/trace.go:171","msg":"trace[1775539070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:472; }","duration":"300.379486ms","start":"2026-02-06T05:56:07.500135Z","end":"2026-02-06T05:56:07.800514Z","steps":["trace[1775539070] 'agreement among raft nodes before linearized reading' (duration: 300.301534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:07.800549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:07.500121Z","time spent":"300.423667ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:56:07.80067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.384473ms","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-02-06T05:56:07.800684Z","caller":"traceutil/trace.go:171","msg":"trace[1889879676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:472; }","duration":"315.435166ms","start":"2026-02-06T05:56:07.485244Z","end":"2026-02-06T05:56:07.800679Z","steps":["trace[1889879676] 'agreement among raft nodes before linearized reading' (duration: 315.407045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:07.800696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:07.485225Z","time spent":"315.467636ms","remote":"127.0.0.1:40178","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-02-06T05:56:07.800747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.851663ms","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-02-06T05:56:07.800787Z","caller":"traceutil/trace.go:171","msg":"trace[1274711065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:472; }","duration":"296.907726ms","start":"2026-02-06T05:56:07.50387Z","end":"2026-02-06T05:56:07.800777Z","steps":["trace[1274711065] 'agreement among raft nodes before linearized reading' (duration: 296.807712ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:07.800903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.375142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:56:07.800926Z","caller":"traceutil/trace.go:171","msg":"trace[1746265217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:472; }","duration":"293.421154ms","start":"2026-02-06T05:56:07.507497Z","end":"2026-02-06T05:56:07.800919Z","steps":["trace[1746265217] 'agreement among raft nodes before linearized reading' (duration: 293.352822ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:08.100292Z","caller":"traceutil/trace.go:171","msg":"trace[1584032308] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"292.536006ms","start":"2026-02-06T05:56:07.807737Z","end":"2026-02-06T05:56:08.100273Z","steps":["trace[1584032308] 'process raft request' (duration: 284.528831ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:08.102156Z","caller":"traceutil/trace.go:171","msg":"trace[590931195] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"284.635695ms","start":"2026-02-06T05:56:07.817504Z","end":"2026-02-06T05:56:08.10214Z","steps":["trace[590931195] 'process raft request' (duration: 284.609954ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:08.102279Z","caller":"traceutil/trace.go:171","msg":"trace[1421838405] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"285.778341ms","start":"2026-02-06T05:56:07.816493Z","end":"2026-02-06T05:56:08.102272Z","steps":["trace[1421838405] 'process raft request' (duration: 285.558374ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:15.529166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.23904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-06T05:56:15.529253Z","caller":"traceutil/trace.go:171","msg":"trace[1159022234] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:493; }","duration":"473.363234ms","start":"2026-02-06T05:56:15.055875Z","end":"2026-02-06T05:56:15.529238Z","steps":["trace[1159022234] 'range keys from in-memory index tree' (duration: 473.169749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:15.52925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:15.060686Z","time spent":"468.544181ms","remote":"127.0.0.1:44582","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-06T05:56:15.529282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:15.05586Z","time spent":"473.415427ms","remote":"127.0.0.1:40018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-06T05:56:15.567603Z","caller":"traceutil/trace.go:171","msg":"trace[699968128] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"332.269621ms","start":"2026-02-06T05:56:15.235313Z","end":"2026-02-06T05:56:15.567582Z","steps":["trace[699968128] 'read index received' (duration: 330.445683ms)","trace[699968128] 'applied index is now lower than readState.Index' (duration: 1.822608ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:56:15.567746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.433076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-njwkc\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-06T05:56:15.567787Z","caller":"traceutil/trace.go:171","msg":"trace[2111043225] range","detail":"{range_begin:/registry/pods/kube-system/cilium-njwkc; range_end:; response_count:1; response_revision:493; }","duration":"332.478128ms","start":"2026-02-06T05:56:15.235299Z","end":"2026-02-06T05:56:15.567777Z","steps":["trace[2111043225] 'agreement among raft nodes before linearized reading' (duration: 332.362224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:15.567811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:15.235234Z","time spent":"332.571051ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-njwkc\" "} {"level":"warn","ts":"2026-02-06T05:56:28.827931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.676751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:56:28.827984Z","caller":"traceutil/trace.go:171","msg":"trace[2043738578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"325.762484ms","start":"2026-02-06T05:56:28.502211Z","end":"2026-02-06T05:56:28.827973Z","steps":["trace[2043738578] 'range keys from in-memory index tree' (duration: 324.678099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:28.82802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:28.502197Z","time spent":"325.818156ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-06T05:56:28.910115Z","caller":"traceutil/trace.go:171","msg":"trace[228053508] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"363.360171ms","start":"2026-02-06T05:56:28.546725Z","end":"2026-02-06T05:56:28.910085Z","steps":["trace[228053508] 'process raft request' (duration: 363.236217ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:28.910327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:28.546694Z","time spent":"363.549017ms","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-06T05:56:29.712739Z","caller":"traceutil/trace.go:171","msg":"trace[2130410198] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"310.435236ms","start":"2026-02-06T05:56:29.402288Z","end":"2026-02-06T05:56:29.712723Z","steps":["trace[2130410198] 'read index received' (duration: 310.294241ms)","trace[2130410198] 'applied index is now lower than readState.Index' (duration: 139.915µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:56:29.712756Z","caller":"traceutil/trace.go:171","msg":"trace[494331718] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"798.86815ms","start":"2026-02-06T05:56:28.913866Z","end":"2026-02-06T05:56:29.712734Z","steps":["trace[494331718] 'process raft request' (duration: 798.722685ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:29.712854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:28.913855Z","time spent":"798.956293ms","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-06T05:56:29.71291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.608352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-8c4sq\" ","response":"range_response_count:1 size:4733"} {"level":"info","ts":"2026-02-06T05:56:29.712949Z","caller":"traceutil/trace.go:171","msg":"trace[1274887891] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-8c4sq; range_end:; response_count:1; response_revision:639; }","duration":"310.677994ms","start":"2026-02-06T05:56:29.402262Z","end":"2026-02-06T05:56:29.71294Z","steps":["trace[1274887891] 'agreement among raft nodes before linearized reading' (duration: 310.535649ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:29.71297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:29.40225Z","time spent":"310.715065ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4756,"request content":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-8c4sq\" "} {"level":"warn","ts":"2026-02-06T05:56:30.460914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446601817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-06T05:56:30.961664Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446601817,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-06T05:56:31.090929Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.371467005s","expected-duration":"1s"} {"level":"info","ts":"2026-02-06T05:56:31.091221Z","caller":"traceutil/trace.go:171","msg":"trace[1313480816] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.371819806s","start":"2026-02-06T05:56:29.719384Z","end":"2026-02-06T05:56:31.091204Z","steps":["trace[1313480816] 'process raft request' (duration: 1.371661161s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.091313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:29.719368Z","time spent":"1.371894069s","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5011,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:31.229644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.234293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:56:31.229712Z","caller":"traceutil/trace.go:171","msg":"trace[1583218061] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"1.269384535s","start":"2026-02-06T05:56:29.960317Z","end":"2026-02-06T05:56:31.229701Z","steps":["trace[1583218061] 'read index received' (duration: 1.131346819s)","trace[1583218061] 'applied index is now lower than readState.Index' (duration: 138.037015ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:56:31.229833Z","caller":"traceutil/trace.go:171","msg":"trace[867296549] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.507195998s","start":"2026-02-06T05:56:29.722631Z","end":"2026-02-06T05:56:31.229827Z","steps":["trace[867296549] 'process raft request' (duration: 1.395654476s)","trace[867296549] 'compare' (duration: 111.072237ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:56:31.229867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:29.722625Z","time spent":"1.507226908s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:31.229994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269677284s","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-02-06T05:56:31.230007Z","caller":"traceutil/trace.go:171","msg":"trace[776456428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"1.269725645s","start":"2026-02-06T05:56:29.960277Z","end":"2026-02-06T05:56:31.230003Z","steps":["trace[776456428] 'agreement among raft nodes before linearized reading' (duration: 1.269664733s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.230021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:29.960264Z","time spent":"1.269755016s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-06T05:56:31.273448Z","caller":"traceutil/trace.go:171","msg":"trace[270199046] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"177.686909ms","start":"2026-02-06T05:56:31.095753Z","end":"2026-02-06T05:56:31.27344Z","steps":["trace[270199046] 'process raft request' (duration: 177.661328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.274395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176319171s","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-02-06T05:56:31.274439Z","caller":"traceutil/trace.go:171","msg":"trace[2147199352] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.176375673s","start":"2026-02-06T05:56:30.09804Z","end":"2026-02-06T05:56:31.274416Z","steps":["trace[2147199352] 'agreement among raft nodes before linearized reading' (duration: 1.17629384s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.274456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:30.098027Z","time spent":"1.176425954s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-06T05:56:31.274798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.681197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-8c4sq\" ","response":"range_response_count:1 size:5026"} {"level":"info","ts":"2026-02-06T05:56:31.274827Z","caller":"traceutil/trace.go:171","msg":"trace[1648510590] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-8c4sq; range_end:; response_count:1; response_revision:643; }","duration":"176.710218ms","start":"2026-02-06T05:56:31.098112Z","end":"2026-02-06T05:56:31.274822Z","steps":["trace[1648510590] 'agreement among raft nodes before linearized reading' (duration: 176.650696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.274905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.830633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:56:31.274921Z","caller":"traceutil/trace.go:171","msg":"trace[37418124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"773.872635ms","start":"2026-02-06T05:56:30.501044Z","end":"2026-02-06T05:56:31.274917Z","steps":["trace[37418124] 'agreement among raft nodes before linearized reading' (duration: 773.849024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.274936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:30.501026Z","time spent":"773.907346ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:56:31.275032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005937045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-06T05:56:31.275049Z","caller":"traceutil/trace.go:171","msg":"trace[1824658535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.005979217s","start":"2026-02-06T05:56:30.269067Z","end":"2026-02-06T05:56:31.275046Z","steps":["trace[1824658535] 'agreement among raft nodes before linearized reading' (duration: 1.005921475s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.275063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:30.269062Z","time spent":"1.005997737s","remote":"127.0.0.1:40178","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-02-06T05:56:31.275138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010973396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-06T05:56:31.275153Z","caller":"traceutil/trace.go:171","msg":"trace[357416128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"1.010996836s","start":"2026-02-06T05:56:30.264153Z","end":"2026-02-06T05:56:31.27515Z","steps":["trace[357416128] 'agreement among raft nodes before linearized reading' (duration: 1.010959285s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.275168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:30.264148Z","time spent":"1.011017106s","remote":"127.0.0.1:40178","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-02-06T05:56:31.275236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019386793s","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-02-06T05:56:31.275251Z","caller":"traceutil/trace.go:171","msg":"trace[1627675509] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"1.019497066s","start":"2026-02-06T05:56:30.255751Z","end":"2026-02-06T05:56:31.275248Z","steps":["trace[1627675509] 'agreement among raft nodes before linearized reading' (duration: 1.019461395s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.275266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:30.255738Z","time spent":"1.019525648s","remote":"127.0.0.1:40178","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-02-06T05:56:31.275337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078159225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-06T05:56:31.275353Z","caller":"traceutil/trace.go:171","msg":"trace[1983254649] range","detail":"{range_begin:/registry/masterleases/162.253.55.207; range_end:; response_count:1; response_revision:643; }","duration":"1.078198345s","start":"2026-02-06T05:56:30.197151Z","end":"2026-02-06T05:56:31.275349Z","steps":["trace[1983254649] 'agreement among raft nodes before linearized reading' (duration: 1.078160974s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:31.275369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:30.197139Z","time spent":"1.078225857s","remote":"127.0.0.1:39916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.207\" "} {"level":"info","ts":"2026-02-06T05:56:31.275731Z","caller":"traceutil/trace.go:171","msg":"trace[1202929018] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"180.015822ms","start":"2026-02-06T05:56:31.09571Z","end":"2026-02-06T05:56:31.275726Z","steps":["trace[1202929018] 'process raft request' (duration: 177.652727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.859516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446601898,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-06T05:56:37.954918Z","caller":"traceutil/trace.go:171","msg":"trace[334892233] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"596.400373ms","start":"2026-02-06T05:56:37.358499Z","end":"2026-02-06T05:56:37.9549Z","steps":["trace[334892233] 'read index received' (duration: 596.271879ms)","trace[334892233] 'applied index is now lower than readState.Index' (duration: 127.834µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:56:37.95511Z","caller":"traceutil/trace.go:171","msg":"trace[510263731] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"643.680128ms","start":"2026-02-06T05:56:37.311422Z","end":"2026-02-06T05:56:37.955102Z","steps":["trace[510263731] 'process raft request' (duration: 643.390619ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.955211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:37.311408Z","time spent":"643.720839ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:37.95539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.888078ms","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-02-06T05:56:37.955411Z","caller":"traceutil/trace.go:171","msg":"trace[1213027029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:686; }","duration":"596.928489ms","start":"2026-02-06T05:56:37.358476Z","end":"2026-02-06T05:56:37.955404Z","steps":["trace[1213027029] 'agreement among raft nodes before linearized reading' (duration: 596.836716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.95543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:37.358463Z","time spent":"596.962511ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-06T05:56:37.955553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.533852ms","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-02-06T05:56:37.955571Z","caller":"traceutil/trace.go:171","msg":"trace[17102641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:686; }","duration":"588.580183ms","start":"2026-02-06T05:56:37.366985Z","end":"2026-02-06T05:56:37.955566Z","steps":["trace[17102641] 'agreement among raft nodes before linearized reading' (duration: 588.524321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.955587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:37.366979Z","time spent":"588.604844ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-06T05:56:37.955712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.117908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:56:37.95573Z","caller":"traceutil/trace.go:171","msg":"trace[67828542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:686; }","duration":"457.174839ms","start":"2026-02-06T05:56:37.49855Z","end":"2026-02-06T05:56:37.955725Z","steps":["trace[67828542] 'agreement among raft nodes before linearized reading' (duration: 457.145558ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.955755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:37.498531Z","time spent":"457.22036ms","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:56:37.955883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.388915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:56:37.955901Z","caller":"traceutil/trace.go:171","msg":"trace[2123607540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:686; }","duration":"587.414596ms","start":"2026-02-06T05:56:37.368481Z","end":"2026-02-06T05:56:37.955895Z","steps":["trace[2123607540] 'agreement among raft nodes before linearized reading' (duration: 587.360384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.955917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:37.368478Z","time spent":"587.435707ms","remote":"127.0.0.1:40178","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-02-06T05:56:37.956019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.55408ms","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-02-06T05:56:37.956036Z","caller":"traceutil/trace.go:171","msg":"trace[1085387883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:686; }","duration":"587.582922ms","start":"2026-02-06T05:56:37.368448Z","end":"2026-02-06T05:56:37.956031Z","steps":["trace[1085387883] 'agreement among raft nodes before linearized reading' (duration: 587.53639ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:37.956052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:37.368441Z","time spent":"587.607492ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-06T05:56:51.843352Z","caller":"traceutil/trace.go:171","msg":"trace[30281348] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"222.32462ms","start":"2026-02-06T05:56:51.621012Z","end":"2026-02-06T05:56:51.843337Z","steps":["trace[30281348] 'process raft request' (duration: 222.224967ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:52.196767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.390524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-06T05:56:52.196841Z","caller":"traceutil/trace.go:171","msg":"trace[1939860868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:731; }","duration":"120.491937ms","start":"2026-02-06T05:56:52.076332Z","end":"2026-02-06T05:56:52.196824Z","steps":["trace[1939860868] 'range keys from in-memory index tree' (duration: 120.25991ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:52.197221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.435704ms","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-02-06T05:56:52.197261Z","caller":"traceutil/trace.go:171","msg":"trace[1196156895] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:731; }","duration":"195.500886ms","start":"2026-02-06T05:56:52.001751Z","end":"2026-02-06T05:56:52.197251Z","steps":["trace[1196156895] 'range keys from in-memory index tree' (duration: 195.353562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:52.197407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.477965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:56:52.197442Z","caller":"traceutil/trace.go:171","msg":"trace[965258021] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:731; }","duration":"195.551968ms","start":"2026-02-06T05:56:52.00188Z","end":"2026-02-06T05:56:52.197432Z","steps":["trace[965258021] 'count revisions from in-memory index tree' (duration: 195.418404ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:52.1976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.759389ms","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-02-06T05:56:52.197632Z","caller":"traceutil/trace.go:171","msg":"trace[1442914294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:731; }","duration":"133.813391ms","start":"2026-02-06T05:56:52.06379Z","end":"2026-02-06T05:56:52.197624Z","steps":["trace[1442914294] 'range keys from in-memory index tree' (duration: 133.686777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:52.197779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.512206ms","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-02-06T05:56:52.197811Z","caller":"traceutil/trace.go:171","msg":"trace[1590667102] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:731; }","duration":"130.557068ms","start":"2026-02-06T05:56:52.067247Z","end":"2026-02-06T05:56:52.197804Z","steps":["trace[1590667102] 'range keys from in-memory index tree' (duration: 130.438384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:52.197953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.583069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-06T05:56:52.197985Z","caller":"traceutil/trace.go:171","msg":"trace[1693288494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:731; }","duration":"125.62677ms","start":"2026-02-06T05:56:52.072351Z","end":"2026-02-06T05:56:52.197977Z","steps":["trace[1693288494] 'range keys from in-memory index tree' (duration: 125.501186ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:52.408614Z","caller":"traceutil/trace.go:171","msg":"trace[1517233614] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"202.033824ms","start":"2026-02-06T05:56:52.206566Z","end":"2026-02-06T05:56:52.4086Z","steps":["trace[1517233614] 'process raft request' (duration: 201.92568ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:52.44789Z","caller":"traceutil/trace.go:171","msg":"trace[772935369] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"224.055956ms","start":"2026-02-06T05:56:52.223819Z","end":"2026-02-06T05:56:52.447875Z","steps":["trace[772935369] 'process raft request' (duration: 224.026385ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:52.448191Z","caller":"traceutil/trace.go:171","msg":"trace[273357202] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"240.421337ms","start":"2026-02-06T05:56:52.207759Z","end":"2026-02-06T05:56:52.448181Z","steps":["trace[273357202] 'process raft request' (duration: 239.964442ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:52.448305Z","caller":"traceutil/trace.go:171","msg":"trace[1799482099] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"240.487768ms","start":"2026-02-06T05:56:52.20781Z","end":"2026-02-06T05:56:52.448297Z","steps":["trace[1799482099] 'process raft request' (duration: 239.974992ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:52.448417Z","caller":"traceutil/trace.go:171","msg":"trace[1447421615] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"224.617073ms","start":"2026-02-06T05:56:52.223778Z","end":"2026-02-06T05:56:52.448395Z","steps":["trace[1447421615] 'process raft request' (duration: 224.040935ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:56.968428Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446602068,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-06T05:56:57.370374Z","caller":"traceutil/trace.go:171","msg":"trace[1132175904] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"904.309568ms","start":"2026-02-06T05:56:56.46601Z","end":"2026-02-06T05:56:57.370319Z","steps":["trace[1132175904] 'read index received' (duration: 904.158604ms)","trace[1132175904] 'applied index is now lower than readState.Index' (duration: 146.534µs)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:56:57.370672Z","caller":"traceutil/trace.go:171","msg":"trace[688187540] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"930.086739ms","start":"2026-02-06T05:56:56.440575Z","end":"2026-02-06T05:56:57.370662Z","steps":["trace[688187540] 'process raft request' (duration: 929.640245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.370747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:56.440559Z","time spent":"930.13819ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:57.370929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.916888ms","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-02-06T05:56:57.37095Z","caller":"traceutil/trace.go:171","msg":"trace[1389883769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:743; }","duration":"904.967269ms","start":"2026-02-06T05:56:56.465976Z","end":"2026-02-06T05:56:57.370944Z","steps":["trace[1389883769] 'agreement among raft nodes before linearized reading' (duration: 904.889957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.370969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:56.465961Z","time spent":"905.003361ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-06T05:56:57.371079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.06431ms","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-02-06T05:56:57.371098Z","caller":"traceutil/trace.go:171","msg":"trace[211009364] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:743; }","duration":"904.105292ms","start":"2026-02-06T05:56:56.466986Z","end":"2026-02-06T05:56:57.371091Z","steps":["trace[211009364] 'agreement among raft nodes before linearized reading' (duration: 904.05406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.371118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:56.466982Z","time spent":"904.129373ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-06T05:56:57.371307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.074737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:56:57.37134Z","caller":"traceutil/trace.go:171","msg":"trace[1387688100] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:743; }","duration":"317.111359ms","start":"2026-02-06T05:56:57.054221Z","end":"2026-02-06T05:56:57.371332Z","steps":["trace[1387688100] 'agreement among raft nodes before linearized reading' (duration: 317.054917ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.371369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:57.054163Z","time spent":"317.196531ms","remote":"127.0.0.1:40100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":10,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:56:57.371855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.952246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:56:57.371893Z","caller":"traceutil/trace.go:171","msg":"trace[578492892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:743; }","duration":"882.021538ms","start":"2026-02-06T05:56:56.489861Z","end":"2026-02-06T05:56:57.371882Z","steps":["trace[578492892] 'agreement among raft nodes before linearized reading' (duration: 881.920185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.371923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:56.489854Z","time spent":"882.06249ms","remote":"127.0.0.1:40178","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-02-06T05:56:57.372175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.20704ms","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-02-06T05:56:57.372208Z","caller":"traceutil/trace.go:171","msg":"trace[653744819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:743; }","duration":"885.241031ms","start":"2026-02-06T05:56:56.486957Z","end":"2026-02-06T05:56:57.372198Z","steps":["trace[653744819] 'agreement among raft nodes before linearized reading' (duration: 885.132688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.372236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:56.48692Z","time spent":"885.309183ms","remote":"127.0.0.1:40178","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-02-06T05:56:57.680208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.640584ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:56:57.681332Z","caller":"traceutil/trace.go:171","msg":"trace[911988960] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:768; }","duration":"176.988716ms","start":"2026-02-06T05:56:57.50433Z","end":"2026-02-06T05:56:57.681319Z","steps":["trace[911988960] 'read index received' (duration: 175.304103ms)","trace[911988960] 'applied index is now lower than readState.Index' (duration: 1.684103ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:56:57.682283Z","caller":"traceutil/trace.go:171","msg":"trace[826530043] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"302.139561ms","start":"2026-02-06T05:56:57.380133Z","end":"2026-02-06T05:56:57.682273Z","steps":["trace[826530043] 'process raft request' (duration: 301.099408ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:57.682311Z","caller":"traceutil/trace.go:171","msg":"trace[720004099] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"304.150685ms","start":"2026-02-06T05:56:57.378153Z","end":"2026-02-06T05:56:57.682304Z","steps":["trace[720004099] 'process raft request' (duration: 120.353342ms)","trace[720004099] 'compare' (duration: 181.411437ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:56:57.683173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:57.380121Z","time spent":"303.009989ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:57.683329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:57.378134Z","time spent":"305.117696ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:56:57.682523Z","caller":"traceutil/trace.go:171","msg":"trace[1350667534] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"300.53399ms","start":"2026-02-06T05:56:57.381983Z","end":"2026-02-06T05:56:57.682517Z","steps":["trace[1350667534] 'process raft request' (duration: 299.316801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.683636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:57.381977Z","time spent":"301.627635ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:56:57.68256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.226436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:56:57.683724Z","caller":"traceutil/trace.go:171","msg":"trace[684753020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"179.411614ms","start":"2026-02-06T05:56:57.504299Z","end":"2026-02-06T05:56:57.683711Z","steps":["trace[684753020] 'agreement among raft nodes before linearized reading' (duration: 178.240596ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:56:57.682494Z","caller":"traceutil/trace.go:171","msg":"trace[1266444717] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"300.692355ms","start":"2026-02-06T05:56:57.381795Z","end":"2026-02-06T05:56:57.682487Z","steps":["trace[1266444717] 'process raft request' (duration: 299.485796ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:56:57.683884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:56:57.381788Z","time spent":"302.069789ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:57:03.903062Z","caller":"traceutil/trace.go:171","msg":"trace[1786565145] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"125.657834ms","start":"2026-02-06T05:57:03.777377Z","end":"2026-02-06T05:57:03.903034Z","steps":["trace[1786565145] 'process raft request' (duration: 125.55091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:03.90382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.578628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:57:03.903869Z","caller":"traceutil/trace.go:171","msg":"trace[1886476686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:762; }","duration":"124.64815ms","start":"2026-02-06T05:57:03.779208Z","end":"2026-02-06T05:57:03.903856Z","steps":["trace[1886476686] 'agreement among raft nodes before linearized reading' (duration: 124.507505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:11.997391Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446602274,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-06T05:57:12.498378Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446602274,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-06T05:57:12.773212Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.27852786s","expected-duration":"1s"} {"level":"info","ts":"2026-02-06T05:57:12.773579Z","caller":"traceutil/trace.go:171","msg":"trace[245900841] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"1.278948754s","start":"2026-02-06T05:57:11.494599Z","end":"2026-02-06T05:57:12.773548Z","steps":["trace[245900841] 'process raft request' (duration: 1.278802129s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:12.773709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:11.494589Z","time spent":"1.279040938s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:57:13.506412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.009955287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-06T05:57:13.506515Z","caller":"traceutil/trace.go:171","msg":"trace[502423176] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.010081241s","start":"2026-02-06T05:57:11.496417Z","end":"2026-02-06T05:57:13.506498Z","steps":["trace[502423176] 'agreement among raft nodes before linearized reading' (duration: 2.009963087s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.506585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:11.496411Z","time spent":"2.010144543s","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/06 05:57:13 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-06T05:57:13.90013Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.101601672s","expected-duration":"1s"} {"level":"info","ts":"2026-02-06T05:57:13.900334Z","caller":"traceutil/trace.go:171","msg":"trace[745963883] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:863; }","duration":"2.403889102s","start":"2026-02-06T05:57:11.49643Z","end":"2026-02-06T05:57:13.900319Z","steps":["trace[745963883] 'read index received' (duration: 1.277772765s)","trace[745963883] 'applied index is now lower than readState.Index' (duration: 1.126115777s)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:57:13.900633Z","caller":"traceutil/trace.go:171","msg":"trace[1662843472] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"1.636897674s","start":"2026-02-06T05:57:12.263709Z","end":"2026-02-06T05:57:13.900607Z","steps":["trace[1662843472] 'process raft request' (duration: 1.636525442s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.90076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:12.263697Z","time spent":"1.636994727s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:57:13.900928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.979446743s","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-02-06T05:57:13.900947Z","caller":"traceutil/trace.go:171","msg":"trace[1796592035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:834; }","duration":"1.979489364s","start":"2026-02-06T05:57:11.921451Z","end":"2026-02-06T05:57:13.900941Z","steps":["trace[1796592035] 'agreement among raft nodes before linearized reading' (duration: 1.979404372s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.900961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:11.921439Z","time spent":"1.979518605s","remote":"127.0.0.1:40178","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-02-06T05:57:13.901053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.77739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:57:13.901066Z","caller":"traceutil/trace.go:171","msg":"trace[562543121] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:834; }","duration":"110.837721ms","start":"2026-02-06T05:57:13.790224Z","end":"2026-02-06T05:57:13.901061Z","steps":["trace[562543121] 'agreement among raft nodes before linearized reading' (duration: 110.78858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.799953831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-06T05:57:13.901222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.101456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:57:13.901236Z","caller":"traceutil/trace.go:171","msg":"trace[1995873053] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:834; }","duration":"1.799989832s","start":"2026-02-06T05:57:12.10124Z","end":"2026-02-06T05:57:13.90123Z","steps":["trace[1995873053] 'agreement among raft nodes before linearized reading' (duration: 1.799964941s)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:13.901248Z","caller":"traceutil/trace.go:171","msg":"trace[1409292798] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:834; }","duration":"899.165008ms","start":"2026-02-06T05:57:13.002076Z","end":"2026-02-06T05:57:13.901241Z","steps":["trace[1409292798] 'agreement among raft nodes before linearized reading' (duration: 899.107897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:12.101228Z","time spent":"1.800019593s","remote":"127.0.0.1:40246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:57:13.901269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:13.002049Z","time spent":"899.21524ms","remote":"127.0.0.1:40308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:57:13.901342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.918103766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:57:13.901356Z","caller":"traceutil/trace.go:171","msg":"trace[1731332131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:834; }","duration":"1.918139086s","start":"2026-02-06T05:57:11.983213Z","end":"2026-02-06T05:57:13.901352Z","steps":["trace[1731332131] 'agreement among raft nodes before linearized reading' (duration: 1.918100385s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:11.983202Z","time spent":"1.918162988s","remote":"127.0.0.1:40178","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-02-06T05:57:13.901372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.304458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:57:13.901386Z","caller":"traceutil/trace.go:171","msg":"trace[614256350] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:834; }","duration":"198.341879ms","start":"2026-02-06T05:57:13.703039Z","end":"2026-02-06T05:57:13.901381Z","steps":["trace[614256350] 'agreement among raft nodes before linearized reading' (duration: 198.316208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.953879363s","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-02-06T05:57:13.901458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.602438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:13.901461Z","caller":"traceutil/trace.go:171","msg":"trace[1447131124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:834; }","duration":"1.953902015s","start":"2026-02-06T05:57:11.947555Z","end":"2026-02-06T05:57:13.901457Z","steps":["trace[1447131124] 'agreement among raft nodes before linearized reading' (duration: 1.953866823s)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:13.901472Z","caller":"traceutil/trace.go:171","msg":"trace[1523948488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:834; }","duration":"394.66626ms","start":"2026-02-06T05:57:13.506802Z","end":"2026-02-06T05:57:13.901468Z","steps":["trace[1523948488] 'agreement among raft nodes before linearized reading' (duration: 394.644549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:13.506785Z","time spent":"394.69899ms","remote":"127.0.0.1:39894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:57:13.901516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.960601907s","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-02-06T05:57:13.901529Z","caller":"traceutil/trace.go:171","msg":"trace[714803455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:834; }","duration":"1.960623568s","start":"2026-02-06T05:57:11.940902Z","end":"2026-02-06T05:57:13.901525Z","steps":["trace[714803455] 'agreement among raft nodes before linearized reading' (duration: 1.960580976s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.90154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:11.940897Z","time spent":"1.960641398s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-06T05:57:13.901559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.757005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:13.901574Z","caller":"traceutil/trace.go:171","msg":"trace[733769249] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:834; }","duration":"494.808446ms","start":"2026-02-06T05:57:13.406761Z","end":"2026-02-06T05:57:13.90157Z","steps":["trace[733769249] 'agreement among raft nodes before linearized reading' (duration: 494.783245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:13.406707Z","time spent":"494.877069ms","remote":"127.0.0.1:40028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:57:13.901659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.740447ms","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-02-06T05:57:13.901671Z","caller":"traceutil/trace.go:171","msg":"trace[526853020] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:834; }","duration":"781.79165ms","start":"2026-02-06T05:57:13.119875Z","end":"2026-02-06T05:57:13.901667Z","steps":["trace[526853020] 'agreement among raft nodes before linearized reading' (duration: 781.770399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:13.901682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:13.119852Z","time spent":"781.82701ms","remote":"127.0.0.1:39984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:57:13.901475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:11.947548Z","time spent":"1.953924115s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-06T05:57:14.658699Z","caller":"traceutil/trace.go:171","msg":"trace[358673246] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"106.652823ms","start":"2026-02-06T05:57:14.552023Z","end":"2026-02-06T05:57:14.658676Z","steps":["trace[358673246] 'process raft request' (duration: 106.529999ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:15.512185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.517714ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-06T05:57:20.663733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.136354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.207\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-06T05:57:20.663781Z","caller":"traceutil/trace.go:171","msg":"trace[811054970] range","detail":"{range_begin:/registry/masterleases/162.253.55.207; range_end:; response_count:1; response_revision:855; }","duration":"463.234088ms","start":"2026-02-06T05:57:20.200536Z","end":"2026-02-06T05:57:20.663771Z","steps":["trace[811054970] 'range keys from in-memory index tree' (duration: 463.00104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:20.663805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:20.200521Z","time spent":"463.2789ms","remote":"127.0.0.1:39916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.207\" "} {"level":"warn","ts":"2026-02-06T05:57:20.663935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.152833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:20.663979Z","caller":"traceutil/trace.go:171","msg":"trace[434710990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:855; }","duration":"167.218544ms","start":"2026-02-06T05:57:20.496749Z","end":"2026-02-06T05:57:20.663968Z","steps":["trace[434710990] 'range keys from in-memory index tree' (duration: 167.107211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:20.664023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.370438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-06T05:57:20.664042Z","caller":"traceutil/trace.go:171","msg":"trace[895513268] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:855; }","duration":"213.41114ms","start":"2026-02-06T05:57:20.450624Z","end":"2026-02-06T05:57:20.664035Z","steps":["trace[895513268] 'count revisions from in-memory index tree' (duration: 213.338527ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:21.206375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:20.667609Z","time spent":"538.762537ms","remote":"127.0.0.1:39916","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-06T05:57:21.206626Z","caller":"traceutil/trace.go:171","msg":"trace[903861444] linearizableReadLoop","detail":"{readStateIndex:887; appliedIndex:887; }","duration":"400.028968ms","start":"2026-02-06T05:57:20.806581Z","end":"2026-02-06T05:57:21.20661Z","steps":["trace[903861444] 'read index received' (duration: 400.025548ms)","trace[903861444] 'applied index is now lower than readState.Index' (duration: 2.65µs)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:21.206732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.139862ms","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-02-06T05:57:21.206751Z","caller":"traceutil/trace.go:171","msg":"trace[517007764] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:855; }","duration":"400.220844ms","start":"2026-02-06T05:57:20.806524Z","end":"2026-02-06T05:57:21.206745Z","steps":["trace[517007764] 'agreement among raft nodes before linearized reading' (duration: 400.122741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:21.206771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:20.80651Z","time spent":"400.257066ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-06T05:57:21.694623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.683985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:57:21.69485Z","caller":"traceutil/trace.go:171","msg":"trace[1435024546] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:887; }","duration":"196.637102ms","start":"2026-02-06T05:57:21.498196Z","end":"2026-02-06T05:57:21.694833Z","steps":["trace[1435024546] 'read index received' (duration: 71.93619ms)","trace[1435024546] 'applied index is now lower than readState.Index' (duration: 124.699862ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:21.694923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.730065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:21.69494Z","caller":"traceutil/trace.go:171","msg":"trace[572583016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:857; }","duration":"196.774666ms","start":"2026-02-06T05:57:21.498159Z","end":"2026-02-06T05:57:21.694934Z","steps":["trace[572583016] 'agreement among raft nodes before linearized reading' (duration: 196.716294ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:21.695151Z","caller":"traceutil/trace.go:171","msg":"trace[514929250] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"486.971096ms","start":"2026-02-06T05:57:21.208171Z","end":"2026-02-06T05:57:21.695142Z","steps":["trace[514929250] 'process raft request' (duration: 65.668191ms)","trace[514929250] 'compare' (duration: 420.52931ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:21.695194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:21.208157Z","time spent":"487.013508ms","remote":"127.0.0.1:39916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:57:21.695377Z","caller":"traceutil/trace.go:171","msg":"trace[164403711] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"483.477ms","start":"2026-02-06T05:57:21.211893Z","end":"2026-02-06T05:57:21.69537Z","steps":["trace[164403711] 'process raft request' (duration: 482.852269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:21.695414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:21.211885Z","time spent":"483.507342ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:57:27.90149Z","caller":"traceutil/trace.go:171","msg":"trace[767210652] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"174.081513ms","start":"2026-02-06T05:57:27.727388Z","end":"2026-02-06T05:57:27.90147Z","steps":["trace[767210652] 'process raft request' (duration: 173.950308ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:57:34.094744Z","caller":"traceutil/trace.go:171","msg":"trace[90268528] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"123.487782ms","start":"2026-02-06T05:57:33.971235Z","end":"2026-02-06T05:57:34.094723Z","steps":["trace[90268528] 'process raft request' (duration: 123.356458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:46.944565Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11978057895446602629,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-06T05:57:47.844449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.404998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-06T05:57:47.844552Z","caller":"traceutil/trace.go:171","msg":"trace[1722110354] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"1.493235292s","start":"2026-02-06T05:57:46.351298Z","end":"2026-02-06T05:57:47.844534Z","steps":["trace[1722110354] 'process raft request' (duration: 844.914206ms)","trace[1722110354] 'compare' (duration: 644.999095ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:47.844604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:46.351289Z","time spent":"1.493287643s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-06T05:57:48.121857Z","caller":"traceutil/trace.go:171","msg":"trace[1386552300] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1030; }","duration":"1.678224387s","start":"2026-02-06T05:57:46.443605Z","end":"2026-02-06T05:57:48.12183Z","steps":["trace[1386552300] 'read index received' (duration: 752.60216ms)","trace[1386552300] 'applied index is now lower than readState.Index' (duration: 925.621097ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:57:48.122002Z","caller":"traceutil/trace.go:171","msg":"trace[1617102185] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"1.770586284s","start":"2026-02-06T05:57:46.351399Z","end":"2026-02-06T05:57:48.121985Z","steps":["trace[1617102185] 'process raft request' (duration: 1.691671982s)","trace[1617102185] 'compare' (duration: 78.635863ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:57:48.122119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:46.351394Z","time spent":"1.770642147s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-06T05:57:48.122226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.619563527s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:48.122315Z","caller":"traceutil/trace.go:171","msg":"trace[880577089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"1.619679471s","start":"2026-02-06T05:57:46.502617Z","end":"2026-02-06T05:57:48.122296Z","steps":["trace[880577089] 'agreement among raft nodes before linearized reading' (duration: 1.619529986s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.122407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:46.502602Z","time spent":"1.619797196s","remote":"127.0.0.1:39886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-06T05:57:48.122508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.429838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:48.122555Z","caller":"traceutil/trace.go:171","msg":"trace[482746462] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:995; }","duration":"551.533911ms","start":"2026-02-06T05:57:47.57101Z","end":"2026-02-06T05:57:48.122543Z","steps":["trace[482746462] 'agreement among raft nodes before linearized reading' (duration: 551.454678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.122592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:47.57098Z","time spent":"551.604393ms","remote":"127.0.0.1:40160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:57:48.122837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.6792343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-06T05:57:48.122875Z","caller":"traceutil/trace.go:171","msg":"trace[1922825922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:995; }","duration":"1.679324633s","start":"2026-02-06T05:57:46.443541Z","end":"2026-02-06T05:57:48.122866Z","steps":["trace[1922825922] 'agreement among raft nodes before linearized reading' (duration: 1.679199999s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.122901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:46.443519Z","time spent":"1.679376274s","remote":"127.0.0.1:40178","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-02-06T05:57:48.123066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.40205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-06T05:57:48.123101Z","caller":"traceutil/trace.go:171","msg":"trace[1022510132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"179.465492ms","start":"2026-02-06T05:57:47.943627Z","end":"2026-02-06T05:57:48.123093Z","steps":["trace[1022510132] 'agreement among raft nodes before linearized reading' (duration: 179.41703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.123176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.119655322s","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-02-06T05:57:48.123226Z","caller":"traceutil/trace.go:171","msg":"trace[1987299170] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:995; }","duration":"1.119766885s","start":"2026-02-06T05:57:47.003451Z","end":"2026-02-06T05:57:48.123217Z","steps":["trace[1987299170] 'agreement among raft nodes before linearized reading' (duration: 1.119233987s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.123292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.004545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-06T05:57:48.123329Z","caller":"traceutil/trace.go:171","msg":"trace[330093739] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:995; }","duration":"247.079207ms","start":"2026-02-06T05:57:47.876241Z","end":"2026-02-06T05:57:48.12332Z","steps":["trace[330093739] 'agreement among raft nodes before linearized reading' (duration: 246.993274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.123263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:47.003424Z","time spent":"1.119830937s","remote":"127.0.0.1:40118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-02-06T05:57:48.123645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.367439243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-06T05:57:48.123715Z","caller":"traceutil/trace.go:171","msg":"trace[1653080210] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:995; }","duration":"1.367524975s","start":"2026-02-06T05:57:46.756178Z","end":"2026-02-06T05:57:48.123703Z","steps":["trace[1653080210] 'agreement among raft nodes before linearized reading' (duration: 1.36735903s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.123755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:46.756168Z","time spent":"1.367579967s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-06T05:57:48.123881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.369950236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-02-06T05:57:48.12393Z","caller":"traceutil/trace.go:171","msg":"trace[446222433] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:995; }","duration":"1.370026068s","start":"2026-02-06T05:57:46.753887Z","end":"2026-02-06T05:57:48.123913Z","steps":["trace[446222433] 'agreement among raft nodes before linearized reading' (duration: 1.369929665s)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:57:48.123961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-06T05:57:46.753869Z","time spent":"1.37008526s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-06T05:59:00.761931Z","caller":"traceutil/trace.go:171","msg":"trace[255523573] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"158.780518ms","start":"2026-02-06T05:59:00.603131Z","end":"2026-02-06T05:59:00.761911Z","steps":["trace[255523573] 'process raft request' (duration: 132.789514ms)","trace[255523573] 'compare' (duration: 25.896681ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:59:00.773789Z","caller":"traceutil/trace.go:171","msg":"trace[2080019835] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1345; }","duration":"127.885568ms","start":"2026-02-06T05:59:00.645876Z","end":"2026-02-06T05:59:00.773761Z","steps":["trace[2080019835] 'read index received' (duration: 90.10617ms)","trace[2080019835] 'applied index is now lower than readState.Index' (duration: 37.777428ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:59:00.77396Z","caller":"traceutil/trace.go:171","msg":"trace[1112937639] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"169.585741ms","start":"2026-02-06T05:59:00.604361Z","end":"2026-02-06T05:59:00.773946Z","steps":["trace[1112937639] 'process raft request' (duration: 169.152277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:00.774643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.718454ms","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-02-06T05:59:00.77472Z","caller":"traceutil/trace.go:171","msg":"trace[1632438551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1295; }","duration":"128.828927ms","start":"2026-02-06T05:59:00.645849Z","end":"2026-02-06T05:59:00.774678Z","steps":["trace[1632438551] 'agreement among raft nodes before linearized reading' (duration: 128.61904ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:11.040788Z","caller":"traceutil/trace.go:171","msg":"trace[1992358887] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"187.861521ms","start":"2026-02-06T05:59:10.852904Z","end":"2026-02-06T05:59:11.040766Z","steps":["trace[1992358887] 'process raft request' (duration: 187.754908ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:11.041621Z","caller":"traceutil/trace.go:171","msg":"trace[1244253053] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1389; }","duration":"178.564707ms","start":"2026-02-06T05:59:10.863047Z","end":"2026-02-06T05:59:11.041611Z","steps":["trace[1244253053] 'read index received' (duration: 177.542104ms)","trace[1244253053] 'applied index is now lower than readState.Index' (duration: 1.021833ms)"],"step_count":2} {"level":"warn","ts":"2026-02-06T05:59:11.042005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.286829ms","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-02-06T05:59:11.042028Z","caller":"traceutil/trace.go:171","msg":"trace[575820905] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1335; }","duration":"164.331361ms","start":"2026-02-06T05:59:10.87769Z","end":"2026-02-06T05:59:11.042021Z","steps":["trace[575820905] 'agreement among raft nodes before linearized reading' (duration: 164.244318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:11.042124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.408461ms","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-02-06T05:59:11.042136Z","caller":"traceutil/trace.go:171","msg":"trace[231047458] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1335; }","duration":"163.433392ms","start":"2026-02-06T05:59:10.878699Z","end":"2026-02-06T05:59:11.042133Z","steps":["trace[231047458] 'agreement among raft nodes before linearized reading' (duration: 163.395921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-06T05:59:11.042303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.254659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-06T05:59:11.042318Z","caller":"traceutil/trace.go:171","msg":"trace[1821231839] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1335; }","duration":"179.280311ms","start":"2026-02-06T05:59:10.863033Z","end":"2026-02-06T05:59:11.042314Z","steps":["trace[1821231839] 'agreement among raft nodes before linearized reading' (duration: 178.619069ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:13.179976Z","caller":"traceutil/trace.go:171","msg":"trace[431859854] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"105.690121ms","start":"2026-02-06T05:59:13.074265Z","end":"2026-02-06T05:59:13.179955Z","steps":["trace[431859854] 'process raft request' (duration: 91.970321ms)","trace[431859854] 'compare' (duration: 13.42315ms)"],"step_count":2} {"level":"info","ts":"2026-02-06T05:59:13.181621Z","caller":"traceutil/trace.go:171","msg":"trace[1398341443] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"104.711749ms","start":"2026-02-06T05:59:13.0769Z","end":"2026-02-06T05:59:13.181611Z","steps":["trace[1398341443] 'process raft request' (duration: 104.688108ms)"],"step_count":1} {"level":"info","ts":"2026-02-06T05:59:13.181783Z","caller":"traceutil/trace.go:171","msg":"trace[1794543182] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"105.192994ms","start":"2026-02-06T05:59:13.076583Z","end":"2026-02-06T05:59:13.181776Z","steps":["trace[1794543182] 'process raft request' (duration: 104.948946ms)"],"step_count":1}