{"level":"warn","ts":"2026-04-08T06:10:03.868913Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:10:03.869008Z","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-04-08T06:10:03.869071Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:10:03.869085Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.207:2380"]} {"level":"info","ts":"2026-04-08T06:10:03.869103Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T06:10:03.869966Z","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-04-08T06:10:03.87004Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://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-04-08T06:10:03.876337Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.101689ms"} {"level":"info","ts":"2026-04-08T06:10:03.883476Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6f1fcbe50562a63a","cluster-id":"a9b9f04f4e8a9fba"} {"level":"info","ts":"2026-04-08T06:10:03.88359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:10:03.883634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 0"} {"level":"info","ts":"2026-04-08T06:10:03.883657Z","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-04-08T06:10:03.883678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became follower at term 1"} {"level":"info","ts":"2026-04-08T06:10:03.883794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"} {"level":"warn","ts":"2026-04-08T06:10:03.893766Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:10:03.894921Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:10:03.895883Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-08T06:10:03.898238Z","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-04-08T06:10:03.898591Z","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-04-08T06:10:03.898638Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T06:10:03.900809Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T06:10:03.900876Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T06:10:03.901237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a switched to configuration voters=(8007342846986331706)"} {"level":"info","ts":"2026-04-08T06:10:03.901493Z","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-04-08T06:10:03.908138Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T06:10:03.908386Z","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-04-08T06:10:03.908411Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:10:03.908959Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.207:2380"} {"level":"info","ts":"2026-04-08T06:10:03.908999Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.207:2380"} {"level":"info","ts":"2026-04-08T06:10:04.884731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:10:04.884948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:10:04.885028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgPreVoteResp from 6f1fcbe50562a63a at term 1"} {"level":"info","ts":"2026-04-08T06:10:04.88508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:10:04.88513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a received MsgVoteResp from 6f1fcbe50562a63a at term 2"} {"level":"info","ts":"2026-04-08T06:10:04.885176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6f1fcbe50562a63a became leader at term 2"} {"level":"info","ts":"2026-04-08T06:10:04.885224Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6f1fcbe50562a63a elected leader 6f1fcbe50562a63a at term 2"} {"level":"info","ts":"2026-04-08T06:10:04.887117Z","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-04-08T06:10:04.887265Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:10:04.887474Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:10:04.88798Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:04.888463Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:10:04.888509Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T06:10:04.88907Z","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-04-08T06:10:04.889175Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:04.889217Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:10:04.891884Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:10:04.901654Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.207:2379"} {"level":"warn","ts":"2026-04-08T06:10:08.635971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.175373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:10:08.636163Z","caller":"traceutil/trace.go:171","msg":"trace[876017815] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"569.816995ms","start":"2026-04-08T06:10:08.066284Z","end":"2026-04-08T06:10:08.636101Z","steps":["trace[876017815] 'process raft request' (duration: 214.981606ms)","trace[876017815] 'compare' (duration: 354.029381ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:10:08.636125Z","caller":"traceutil/trace.go:171","msg":"trace[2104554370] linearizableReadLoop","detail":"{readStateIndex:206; appliedIndex:205; }","duration":"465.395459ms","start":"2026-04-08T06:10:08.170674Z","end":"2026-04-08T06:10:08.63607Z","steps":["trace[2104554370] 'read index received' (duration: 110.494979ms)","trace[2104554370] 'applied index is now lower than readState.Index' (duration: 354.89933ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:10:08.63631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:08.06626Z","time spent":"569.991937ms","remote":"127.0.0.1:50594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T06:10:08.636353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.626181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:10:08.636471Z","caller":"traceutil/trace.go:171","msg":"trace[68144521] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:201; }","duration":"465.828263ms","start":"2026-04-08T06:10:08.170618Z","end":"2026-04-08T06:10:08.636447Z","steps":["trace[68144521] 'agreement among raft nodes before linearized reading' (duration: 465.55483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:08.63652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:08.170595Z","time spent":"465.914855ms","remote":"127.0.0.1:50620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-04-08T06:10:08.748685Z","caller":"traceutil/trace.go:171","msg":"trace[1369620160] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"110.060724ms","start":"2026-04-08T06:10:08.638586Z","end":"2026-04-08T06:10:08.748647Z","steps":["trace[1369620160] 'process raft request' (duration: 109.937343ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:08.749159Z","caller":"traceutil/trace.go:171","msg":"trace[2130717756] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"108.73133ms","start":"2026-04-08T06:10:08.640407Z","end":"2026-04-08T06:10:08.749138Z","steps":["trace[2130717756] 'process raft request' (duration: 108.624269ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.526394Z","caller":"traceutil/trace.go:171","msg":"trace[1702375569] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"149.668073ms","start":"2026-04-08T06:10:33.376701Z","end":"2026-04-08T06:10:33.526369Z","steps":["trace[1702375569] 'process raft request' (duration: 149.489462ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.545513Z","caller":"traceutil/trace.go:171","msg":"trace[2038404619] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"108.636793ms","start":"2026-04-08T06:10:33.436858Z","end":"2026-04-08T06:10:33.545495Z","steps":["trace[2038404619] 'process raft request' (duration: 108.542762ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.545794Z","caller":"traceutil/trace.go:171","msg":"trace[954994959] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"164.981555ms","start":"2026-04-08T06:10:33.380802Z","end":"2026-04-08T06:10:33.545784Z","steps":["trace[954994959] 'process raft request' (duration: 164.083648ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.545914Z","caller":"traceutil/trace.go:171","msg":"trace[1480011576] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"164.903934ms","start":"2026-04-08T06:10:33.381002Z","end":"2026-04-08T06:10:33.545906Z","steps":["trace[1480011576] 'process raft request' (duration: 163.961127ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.546067Z","caller":"traceutil/trace.go:171","msg":"trace[337013601] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"159.665966ms","start":"2026-04-08T06:10:33.386391Z","end":"2026-04-08T06:10:33.546057Z","steps":["trace[337013601] 'process raft request' (duration: 158.607648ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.546314Z","caller":"traceutil/trace.go:171","msg":"trace[1817454431] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"155.990689ms","start":"2026-04-08T06:10:33.390314Z","end":"2026-04-08T06:10:33.546304Z","steps":["trace[1817454431] 'process raft request' (duration: 154.720609ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.54674Z","caller":"traceutil/trace.go:171","msg":"trace[1278303539] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"150.393139ms","start":"2026-04-08T06:10:33.396326Z","end":"2026-04-08T06:10:33.54672Z","steps":["trace[1278303539] 'process raft request' (duration: 148.744496ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.546807Z","caller":"traceutil/trace.go:171","msg":"trace[863306447] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"150.397158ms","start":"2026-04-08T06:10:33.396376Z","end":"2026-04-08T06:10:33.546773Z","steps":["trace[863306447] 'process raft request' (duration: 148.728676ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.546954Z","caller":"traceutil/trace.go:171","msg":"trace[952110045] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"141.977237ms","start":"2026-04-08T06:10:33.404928Z","end":"2026-04-08T06:10:33.546905Z","steps":["trace[952110045] 'process raft request' (duration: 140.272124ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.546989Z","caller":"traceutil/trace.go:171","msg":"trace[1667080082] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"122.548444ms","start":"2026-04-08T06:10:33.424407Z","end":"2026-04-08T06:10:33.546956Z","steps":["trace[1667080082] 'process raft request' (duration: 120.887902ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:33.54686Z","caller":"traceutil/trace.go:171","msg":"trace[883272573] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"149.23333ms","start":"2026-04-08T06:10:33.397542Z","end":"2026-04-08T06:10:33.546775Z","steps":["trace[883272573] 'process raft request' (duration: 147.616758ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:40.130016Z","caller":"traceutil/trace.go:171","msg":"trace[515487497] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"308.620728ms","start":"2026-04-08T06:10:39.82137Z","end":"2026-04-08T06:10:40.129991Z","steps":["trace[515487497] 'process raft request' (duration: 307.208899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.130681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:39.821322Z","time spent":"308.980921ms","remote":"127.0.0.1:50580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:10:40.318905Z","caller":"traceutil/trace.go:171","msg":"trace[369141137] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"121.693656ms","start":"2026-04-08T06:10:40.19719Z","end":"2026-04-08T06:10:40.318884Z","steps":["trace[369141137] 'read index received' (duration: 121.511935ms)","trace[369141137] 'applied index is now lower than readState.Index' (duration: 180.731µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:10:40.318965Z","caller":"traceutil/trace.go:171","msg":"trace[1851845842] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"139.340126ms","start":"2026-04-08T06:10:40.179608Z","end":"2026-04-08T06:10:40.318949Z","steps":["trace[1851845842] 'process raft request' (duration: 139.151725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.319102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.905718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T06:10:40.31913Z","caller":"traceutil/trace.go:171","msg":"trace[2054036395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"121.974009ms","start":"2026-04-08T06:10:40.197149Z","end":"2026-04-08T06:10:40.319123Z","steps":["trace[2054036395] 'agreement among raft nodes before linearized reading' (duration: 121.817838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.31927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.097295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T06:10:40.319356Z","caller":"traceutil/trace.go:171","msg":"trace[1099325731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"117.217776ms","start":"2026-04-08T06:10:40.202122Z","end":"2026-04-08T06:10:40.31934Z","steps":["trace[1099325731] 'agreement among raft nodes before linearized reading' (duration: 116.922794ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:40.726725Z","caller":"traceutil/trace.go:171","msg":"trace[583455612] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"348.94223ms","start":"2026-04-08T06:10:40.37776Z","end":"2026-04-08T06:10:40.726702Z","steps":["trace[583455612] 'process raft request' (duration: 348.825809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.7269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:40.377738Z","time spent":"349.104121ms","remote":"127.0.0.1:50660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T06:10:40.989012Z","caller":"traceutil/trace.go:171","msg":"trace[80515997] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"404.710029ms","start":"2026-04-08T06:10:40.584281Z","end":"2026-04-08T06:10:40.988991Z","steps":["trace[80515997] 'read index received' (duration: 142.239866ms)","trace[80515997] 'applied index is now lower than readState.Index' (duration: 262.469173ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:10:40.989154Z","caller":"traceutil/trace.go:171","msg":"trace[99525997] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"607.498697ms","start":"2026-04-08T06:10:40.381624Z","end":"2026-04-08T06:10:40.989123Z","steps":["trace[99525997] 'process raft request' (duration: 607.177244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.989319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.023441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T06:10:40.989402Z","caller":"traceutil/trace.go:171","msg":"trace[1685930074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"405.140471ms","start":"2026-04-08T06:10:40.584241Z","end":"2026-04-08T06:10:40.989381Z","steps":["trace[1685930074] 'agreement among raft nodes before linearized reading' (duration: 404.90848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.989319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:40.381611Z","time spent":"607.620057ms","remote":"127.0.0.1:50660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:10:40.989505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:10:40.584226Z","time spent":"405.258163ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T06:10:40.994579Z","caller":"traceutil/trace.go:171","msg":"trace[1657216005] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"264.189935ms","start":"2026-04-08T06:10:40.730367Z","end":"2026-04-08T06:10:40.994557Z","steps":["trace[1657216005] 'process raft request' (duration: 263.902083ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:40.994592Z","caller":"traceutil/trace.go:171","msg":"trace[1147605196] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"262.818656ms","start":"2026-04-08T06:10:40.731753Z","end":"2026-04-08T06:10:40.994571Z","steps":["trace[1147605196] 'process raft request' (duration: 262.650975ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:40.994641Z","caller":"traceutil/trace.go:171","msg":"trace[904652330] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"263.352319ms","start":"2026-04-08T06:10:40.731267Z","end":"2026-04-08T06:10:40.994619Z","steps":["trace[904652330] 'process raft request' (duration: 263.105687ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:40.994763Z","caller":"traceutil/trace.go:171","msg":"trace[1989864245] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"262.134921ms","start":"2026-04-08T06:10:40.732618Z","end":"2026-04-08T06:10:40.994753Z","steps":["trace[1989864245] 'process raft request' (duration: 261.846919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:10:40.994882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.972933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:10:40.99494Z","caller":"traceutil/trace.go:171","msg":"trace[1608063914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"230.070293ms","start":"2026-04-08T06:10:40.764853Z","end":"2026-04-08T06:10:40.994923Z","steps":["trace[1608063914] 'agreement among raft nodes before linearized reading' (duration: 229.955522ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:55.284737Z","caller":"traceutil/trace.go:171","msg":"trace[208462950] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"178.496603ms","start":"2026-04-08T06:10:55.106222Z","end":"2026-04-08T06:10:55.284718Z","steps":["trace[208462950] 'process raft request' (duration: 178.379642ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:10:55.356115Z","caller":"traceutil/trace.go:171","msg":"trace[1926416997] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"249.103358ms","start":"2026-04-08T06:10:55.106985Z","end":"2026-04-08T06:10:55.356089Z","steps":["trace[1926416997] 'process raft request' (duration: 248.105182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:08.099706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.879271ms","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-04-08T06:11:08.099796Z","caller":"traceutil/trace.go:171","msg":"trace[898793455] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:900; }","duration":"149.045733ms","start":"2026-04-08T06:11:07.950731Z","end":"2026-04-08T06:11:08.099777Z","steps":["trace[898793455] 'count revisions from in-memory index tree' (duration: 148.747891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:08.10006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.204117ms","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-04-08T06:11:08.100081Z","caller":"traceutil/trace.go:171","msg":"trace[584948412] range","detail":"{range_begin:/registry/masterleases/162.253.55.207; range_end:; response_count:1; response_revision:900; }","duration":"228.283327ms","start":"2026-04-08T06:11:07.871791Z","end":"2026-04-08T06:11:08.100074Z","steps":["trace[584948412] 'range keys from in-memory index tree' (duration: 227.989266ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:11:08.100152Z","caller":"traceutil/trace.go:171","msg":"trace[1528793417] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"101.644217ms","start":"2026-04-08T06:11:07.998497Z","end":"2026-04-08T06:11:08.100141Z","steps":["trace[1528793417] 'process raft request' (duration: 100.109098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:49.992307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.162402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-08T06:11:49.992391Z","caller":"traceutil/trace.go:171","msg":"trace[1127400329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1414; }","duration":"171.302893ms","start":"2026-04-08T06:11:49.82107Z","end":"2026-04-08T06:11:49.992373Z","steps":["trace[1127400329] 'range keys from in-memory index tree' (duration: 170.998961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:11:49.99231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.80214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:11:49.992546Z","caller":"traceutil/trace.go:171","msg":"trace[1485185627] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1414; }","duration":"167.076981ms","start":"2026-04-08T06:11:49.825449Z","end":"2026-04-08T06:11:49.992526Z","steps":["trace[1485185627] 'range keys from in-memory index tree' (duration: 166.643719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:14.555621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.490137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:12:14.555776Z","caller":"traceutil/trace.go:171","msg":"trace[1111726349] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1901; }","duration":"387.909551ms","start":"2026-04-08T06:12:14.167846Z","end":"2026-04-08T06:12:14.555756Z","steps":["trace[1111726349] 'read index received' (duration: 285.134683ms)","trace[1111726349] 'applied index is now lower than readState.Index' (duration: 102.773268ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:14.556081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.218262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T06:12:14.556177Z","caller":"traceutil/trace.go:171","msg":"trace[63751328] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1833; }","duration":"388.380523ms","start":"2026-04-08T06:12:14.167778Z","end":"2026-04-08T06:12:14.556159Z","steps":["trace[63751328] 'agreement among raft nodes before linearized reading' (duration: 388.113192ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:14.556173Z","caller":"traceutil/trace.go:171","msg":"trace[329319992] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"441.014549ms","start":"2026-04-08T06:12:14.115123Z","end":"2026-04-08T06:12:14.556137Z","steps":["trace[329319992] 'process raft request' (duration: 337.892219ms)","trace[329319992] 'compare' (duration: 102.270626ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:14.556223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:14.167747Z","time spent":"388.466834ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T06:12:14.556378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.999465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:12:14.55677Z","caller":"traceutil/trace.go:171","msg":"trace[1614352343] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1833; }","duration":"335.416587ms","start":"2026-04-08T06:12:14.221255Z","end":"2026-04-08T06:12:14.556672Z","steps":["trace[1614352343] 'agreement among raft nodes before linearized reading' (duration: 334.914814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:14.556876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.270055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0b44e7fa-4dbe-419c-9e29-0b045ea0d979\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-08T06:12:14.556918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:14.221229Z","time spent":"335.656089ms","remote":"127.0.0.1:50660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":23,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-04-08T06:12:14.557003Z","caller":"traceutil/trace.go:171","msg":"trace[1148833846] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0b44e7fa-4dbe-419c-9e29-0b045ea0d979; range_end:; response_count:1; response_revision:1833; }","duration":"372.478187ms","start":"2026-04-08T06:12:14.184504Z","end":"2026-04-08T06:12:14.556983Z","steps":["trace[1148833846] 'agreement among raft nodes before linearized reading' (duration: 372.027475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:14.55713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:14.184485Z","time spent":"372.604088ms","remote":"127.0.0.1:50660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0b44e7fa-4dbe-419c-9e29-0b045ea0d979\" "} {"level":"warn","ts":"2026-04-08T06:12:14.557527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:12:14.115108Z","time spent":"442.298025ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:12:14.983303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.189366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:14.98364Z","caller":"traceutil/trace.go:171","msg":"trace[189268079] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:1835; }","duration":"135.581698ms","start":"2026-04-08T06:12:14.848018Z","end":"2026-04-08T06:12:14.983599Z","steps":["trace[189268079] 'count revisions from in-memory index tree' (duration: 135.071805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:14.983661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.889529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:12:14.983931Z","caller":"traceutil/trace.go:171","msg":"trace[374636225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1835; }","duration":"138.20227ms","start":"2026-04-08T06:12:14.845702Z","end":"2026-04-08T06:12:14.983904Z","steps":["trace[374636225] 'range keys from in-memory index tree' (duration: 137.699607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:14.983687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.927833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-08T06:12:14.984072Z","caller":"traceutil/trace.go:171","msg":"trace[1230389479] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1835; }","duration":"174.473896ms","start":"2026-04-08T06:12:14.809586Z","end":"2026-04-08T06:12:14.98406Z","steps":["trace[1230389479] 'range keys from in-memory index tree' (duration: 173.746443ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:29.056364Z","caller":"traceutil/trace.go:171","msg":"trace[1258066257] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"285.177078ms","start":"2026-04-08T06:12:28.771166Z","end":"2026-04-08T06:12:29.056343Z","steps":["trace[1258066257] 'process raft request' (duration: 269.415877ms)","trace[1258066257] 'compare' (duration: 15.672833ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:47.857746Z","caller":"traceutil/trace.go:171","msg":"trace[534561401] linearizableReadLoop","detail":"{readStateIndex:2140; appliedIndex:2139; }","duration":"101.617299ms","start":"2026-04-08T06:12:47.756078Z","end":"2026-04-08T06:12:47.857696Z","steps":["trace[534561401] 'read index received' (duration: 101.390205ms)","trace[534561401] 'applied index is now lower than readState.Index' (duration: 226.114µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:47.858217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.12865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-08T06:12:47.85828Z","caller":"traceutil/trace.go:171","msg":"trace[1900948348] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2065; }","duration":"102.234217ms","start":"2026-04-08T06:12:47.756029Z","end":"2026-04-08T06:12:47.858264Z","steps":["trace[1900948348] 'agreement among raft nodes before linearized reading' (duration: 102.058266ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:47.858402Z","caller":"traceutil/trace.go:171","msg":"trace[1852808994] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"138.463128ms","start":"2026-04-08T06:12:47.719929Z","end":"2026-04-08T06:12:47.858392Z","steps":["trace[1852808994] 'process raft request' (duration: 137.596184ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:48.008561Z","caller":"traceutil/trace.go:171","msg":"trace[1883585132] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"108.58272ms","start":"2026-04-08T06:12:47.899961Z","end":"2026-04-08T06:12:48.008544Z","steps":["trace[1883585132] 'process raft request' (duration: 108.514666ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:48.008748Z","caller":"traceutil/trace.go:171","msg":"trace[657479208] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"116.456373ms","start":"2026-04-08T06:12:47.892259Z","end":"2026-04-08T06:12:48.008715Z","steps":["trace[657479208] 'process raft request' (duration: 110.701856ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:48.00886Z","caller":"traceutil/trace.go:171","msg":"trace[512698667] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"106.223595ms","start":"2026-04-08T06:12:47.902611Z","end":"2026-04-08T06:12:48.008835Z","steps":["trace[512698667] 'process raft request' (duration: 105.903305ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:48.885005Z","caller":"traceutil/trace.go:171","msg":"trace[1501322295] linearizableReadLoop","detail":"{readStateIndex:2147; appliedIndex:2146; }","duration":"124.938097ms","start":"2026-04-08T06:12:48.760036Z","end":"2026-04-08T06:12:48.884974Z","steps":["trace[1501322295] 'read index received' (duration: 124.685832ms)","trace[1501322295] 'applied index is now lower than readState.Index' (duration: 250.995µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:48.885135Z","caller":"traceutil/trace.go:171","msg":"trace[1031902271] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"127.210003ms","start":"2026-04-08T06:12:48.757899Z","end":"2026-04-08T06:12:48.885109Z","steps":["trace[1031902271] 'process raft request' (duration: 126.879653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:48.885395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.217623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-08T06:12:48.885658Z","caller":"traceutil/trace.go:171","msg":"trace[1369666650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2071; }","duration":"125.604157ms","start":"2026-04-08T06:12:48.760017Z","end":"2026-04-08T06:12:48.885621Z","steps":["trace[1369666650] 'agreement among raft nodes before linearized reading' (duration: 125.113817ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:49.090744Z","caller":"traceutil/trace.go:171","msg":"trace[690313589] linearizableReadLoop","detail":"{readStateIndex:2149; appliedIndex:2147; }","duration":"161.207065ms","start":"2026-04-08T06:12:48.929518Z","end":"2026-04-08T06:12:49.090725Z","steps":["trace[690313589] 'read index received' (duration: 81.179707ms)","trace[690313589] 'applied index is now lower than readState.Index' (duration: 80.026398ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:49.090809Z","caller":"traceutil/trace.go:171","msg":"trace[1433114590] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"201.370332ms","start":"2026-04-08T06:12:48.889399Z","end":"2026-04-08T06:12:49.090769Z","steps":["trace[1433114590] 'process raft request' (duration: 121.075167ms)","trace[1433114590] 'compare' (duration: 80.091853ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:49.09088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.345454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:12:49.09091Z","caller":"traceutil/trace.go:171","msg":"trace[1272755159] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2073; }","duration":"161.45384ms","start":"2026-04-08T06:12:48.929448Z","end":"2026-04-08T06:12:49.090902Z","steps":["trace[1272755159] 'agreement among raft nodes before linearized reading' (duration: 161.353194ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:49.091029Z","caller":"traceutil/trace.go:171","msg":"trace[277071675] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"201.371191ms","start":"2026-04-08T06:12:48.889641Z","end":"2026-04-08T06:12:49.091013Z","steps":["trace[277071675] 'process raft request' (duration: 201.047892ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:12:49.34592Z","caller":"traceutil/trace.go:171","msg":"trace[153762689] linearizableReadLoop","detail":"{readStateIndex:2150; appliedIndex:2149; }","duration":"189.309301ms","start":"2026-04-08T06:12:49.156588Z","end":"2026-04-08T06:12:49.345897Z","steps":["trace[153762689] 'read index received' (duration: 166.953102ms)","trace[153762689] 'applied index is now lower than readState.Index' (duration: 22.355079ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:12:49.34605Z","caller":"traceutil/trace.go:171","msg":"trace[2042067652] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"196.942459ms","start":"2026-04-08T06:12:49.149091Z","end":"2026-04-08T06:12:49.346033Z","steps":["trace[2042067652] 'process raft request' (duration: 174.464282ms)","trace[2042067652] 'compare' (duration: 22.089134ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:12:49.34619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.757809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T06:12:49.346246Z","caller":"traceutil/trace.go:171","msg":"trace[1458165066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2074; }","duration":"188.864156ms","start":"2026-04-08T06:12:49.157365Z","end":"2026-04-08T06:12:49.346229Z","steps":["trace[1458165066] 'agreement among raft nodes before linearized reading' (duration: 188.695036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:12:49.346576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.937839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T06:12:49.346746Z","caller":"traceutil/trace.go:171","msg":"trace[345840435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2074; }","duration":"190.163502ms","start":"2026-04-08T06:12:49.156562Z","end":"2026-04-08T06:12:49.346725Z","steps":["trace[345840435] 'agreement among raft nodes before linearized reading' (duration: 189.739407ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:14:22.34133Z","caller":"traceutil/trace.go:171","msg":"trace[426872104] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"166.392037ms","start":"2026-04-08T06:14:22.174904Z","end":"2026-04-08T06:14:22.341296Z","steps":["trace[426872104] 'process raft request' (duration: 111.185913ms)","trace[426872104] 'compare' (duration: 55.084652ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:17:10.005209Z","caller":"traceutil/trace.go:171","msg":"trace[95450076] transaction","detail":"{read_only:false; response_revision:3727; number_of_response:1; }","duration":"116.067368ms","start":"2026-04-08T06:17:09.889108Z","end":"2026-04-08T06:17:10.005175Z","steps":["trace[95450076] 'process raft request' (duration: 77.226545ms)","trace[95450076] 'compare' (duration: 38.411393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:18:06.648239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.143751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:18:06.648476Z","caller":"traceutil/trace.go:171","msg":"trace[603811425] transaction","detail":"{read_only:false; response_revision:4562; number_of_response:1; }","duration":"206.192625ms","start":"2026-04-08T06:18:06.442217Z","end":"2026-04-08T06:18:06.648409Z","steps":["trace[603811425] 'process raft request' (duration: 81.792059ms)","trace[603811425] 'compare' (duration: 123.970327ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:06.648546Z","caller":"traceutil/trace.go:171","msg":"trace[1254269063] linearizableReadLoop","detail":"{readStateIndex:4733; appliedIndex:4732; }","duration":"109.903778ms","start":"2026-04-08T06:18:06.538633Z","end":"2026-04-08T06:18:06.648537Z","steps":["trace[1254269063] 'read index received' (duration: 41.111µs)","trace[1254269063] 'applied index is now lower than readState.Index' (duration: 109.861717ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:18:06.648761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.123463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-08T06:18:06.648506Z","caller":"traceutil/trace.go:171","msg":"trace[2039650714] transaction","detail":"{read_only:false; response_revision:4563; number_of_response:1; }","duration":"107.330283ms","start":"2026-04-08T06:18:06.541148Z","end":"2026-04-08T06:18:06.648478Z","steps":["trace[2039650714] 'process raft request' (duration: 107.22163ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:06.6488Z","caller":"traceutil/trace.go:171","msg":"trace[422556899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4563; }","duration":"110.206254ms","start":"2026-04-08T06:18:06.538585Z","end":"2026-04-08T06:18:06.648791Z","steps":["trace[422556899] 'agreement among raft nodes before linearized reading' (duration: 110.032031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:06.64916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.441698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-sq667\" ","response":"range_response_count:1 size:9716"} {"level":"info","ts":"2026-04-08T06:18:06.649234Z","caller":"traceutil/trace.go:171","msg":"trace[426457983] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-sq667; range_end:; response_count:1; response_revision:4563; }","duration":"109.567741ms","start":"2026-04-08T06:18:06.539651Z","end":"2026-04-08T06:18:06.649219Z","steps":["trace[426457983] 'agreement among raft nodes before linearized reading' (duration: 109.351116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:07.907963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.39376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6404a99c-3bf3-4830-ad7b-9c76d5d7cdf9\" ","response":"range_response_count:1 size:4079"} {"level":"info","ts":"2026-04-08T06:18:07.908019Z","caller":"traceutil/trace.go:171","msg":"trace[1227369232] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6404a99c-3bf3-4830-ad7b-9c76d5d7cdf9; range_end:; response_count:1; response_revision:4627; }","duration":"217.507653ms","start":"2026-04-08T06:18:07.690499Z","end":"2026-04-08T06:18:07.908007Z","steps":["trace[1227369232] 'range keys from in-memory index tree' (duration: 217.220297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:07.908686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.722096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:18:07.908708Z","caller":"traceutil/trace.go:171","msg":"trace[1591551036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4627; }","duration":"144.780228ms","start":"2026-04-08T06:18:07.763923Z","end":"2026-04-08T06:18:07.908703Z","steps":["trace[1591551036] 'range keys from in-memory index tree' (duration: 144.642625ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:12.000899Z","caller":"traceutil/trace.go:171","msg":"trace[353909900] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"147.515398ms","start":"2026-04-08T06:18:11.853351Z","end":"2026-04-08T06:18:12.000866Z","steps":["trace[353909900] 'process raft request' (duration: 140.422737ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:12.025108Z","caller":"traceutil/trace.go:171","msg":"trace[387662334] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4872; }","duration":"139.552619ms","start":"2026-04-08T06:18:11.88553Z","end":"2026-04-08T06:18:12.025082Z","steps":["trace[387662334] 'read index received' (duration: 108.349468ms)","trace[387662334] 'applied index is now lower than readState.Index' (duration: 31.202381ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:12.025165Z","caller":"traceutil/trace.go:171","msg":"trace[1218777996] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"165.258374ms","start":"2026-04-08T06:18:11.859881Z","end":"2026-04-08T06:18:12.02514Z","steps":["trace[1218777996] 'process raft request' (duration: 165.05141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:12.025293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.745283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:18:12.025338Z","caller":"traceutil/trace.go:171","msg":"trace[923668984] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:4701; }","duration":"139.812064ms","start":"2026-04-08T06:18:11.885513Z","end":"2026-04-08T06:18:12.025325Z","steps":["trace[923668984] 'agreement among raft nodes before linearized reading' (duration: 139.709942ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:13.38635Z","caller":"traceutil/trace.go:171","msg":"trace[1917090550] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"158.881236ms","start":"2026-04-08T06:18:13.227437Z","end":"2026-04-08T06:18:13.386319Z","steps":["trace[1917090550] 'process raft request' (duration: 72.547397ms)","trace[1917090550] 'compare' (duration: 85.958641ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:13.386379Z","caller":"traceutil/trace.go:171","msg":"trace[301465331] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"148.768342ms","start":"2026-04-08T06:18:13.237583Z","end":"2026-04-08T06:18:13.386351Z","steps":["trace[301465331] 'process raft request' (duration: 148.624249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:13.386628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.846929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:18:13.386584Z","caller":"traceutil/trace.go:171","msg":"trace[1383188479] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"115.963127ms","start":"2026-04-08T06:18:13.270579Z","end":"2026-04-08T06:18:13.386542Z","steps":["trace[1383188479] 'process raft request' (duration: 115.757832ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:13.3864Z","caller":"traceutil/trace.go:171","msg":"trace[1106398806] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"116.517788ms","start":"2026-04-08T06:18:13.26986Z","end":"2026-04-08T06:18:13.386378Z","steps":["trace[1106398806] 'process raft request' (duration: 116.439127ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:13.386676Z","caller":"traceutil/trace.go:171","msg":"trace[539887646] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4732; }","duration":"111.963562ms","start":"2026-04-08T06:18:13.274699Z","end":"2026-04-08T06:18:13.386662Z","steps":["trace[539887646] 'agreement among raft nodes before linearized reading' (duration: 111.807369ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:13.386488Z","caller":"traceutil/trace.go:171","msg":"trace[1053350595] linearizableReadLoop","detail":"{readStateIndex:4906; appliedIndex:4902; }","duration":"111.720196ms","start":"2026-04-08T06:18:13.274754Z","end":"2026-04-08T06:18:13.386474Z","steps":["trace[1053350595] 'read index received' (duration: 25.238844ms)","trace[1053350595] 'applied index is now lower than readState.Index' (duration: 86.480162ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:23.532642Z","caller":"traceutil/trace.go:171","msg":"trace[244501451] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"338.561716ms","start":"2026-04-08T06:18:23.194049Z","end":"2026-04-08T06:18:23.532611Z","steps":["trace[244501451] 'process raft request' (duration: 338.259859ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:23.532872Z","caller":"traceutil/trace.go:171","msg":"trace[1348458269] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"114.457131ms","start":"2026-04-08T06:18:23.41839Z","end":"2026-04-08T06:18:23.532847Z","steps":["trace[1348458269] 'process raft request' (duration: 114.145745ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:23.532881Z","caller":"traceutil/trace.go:171","msg":"trace[83100982] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"113.87244ms","start":"2026-04-08T06:18:23.418988Z","end":"2026-04-08T06:18:23.53286Z","steps":["trace[83100982] 'process raft request' (duration: 113.760447ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:23.532917Z","caller":"traceutil/trace.go:171","msg":"trace[294839187] linearizableReadLoop","detail":"{readStateIndex:5014; appliedIndex:5012; }","duration":"303.914776ms","start":"2026-04-08T06:18:23.228981Z","end":"2026-04-08T06:18:23.532896Z","steps":["trace[294839187] 'read index received' (duration: 222.159473ms)","trace[294839187] 'applied index is now lower than readState.Index' (duration: 81.754452ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:23.533015Z","caller":"traceutil/trace.go:171","msg":"trace[1023519972] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"110.922967ms","start":"2026-04-08T06:18:23.422053Z","end":"2026-04-08T06:18:23.532976Z","steps":["trace[1023519972] 'process raft request' (duration: 110.767154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:23.533225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.239762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T06:18:23.533283Z","caller":"traceutil/trace.go:171","msg":"trace[987388957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4838; }","duration":"304.330764ms","start":"2026-04-08T06:18:23.228939Z","end":"2026-04-08T06:18:23.53327Z","steps":["trace[987388957] 'agreement among raft nodes before linearized reading' (duration: 304.155791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:23.533313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:23.228927Z","time spent":"304.378655ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T06:18:23.533709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.870716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T06:18:23.533751Z","caller":"traceutil/trace.go:171","msg":"trace[1335565416] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4838; }","duration":"101.940938ms","start":"2026-04-08T06:18:23.4318Z","end":"2026-04-08T06:18:23.533741Z","steps":["trace[1335565416] 'agreement among raft nodes before linearized reading' (duration: 101.842276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:23.533789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:23.194008Z","time spent":"338.725519ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:18:23.533878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.870973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T06:18:23.533913Z","caller":"traceutil/trace.go:171","msg":"trace[814783657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4838; }","duration":"283.925844ms","start":"2026-04-08T06:18:23.249979Z","end":"2026-04-08T06:18:23.533905Z","steps":["trace[814783657] 'agreement among raft nodes before linearized reading' (duration: 283.611497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:09.875781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.011525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:19:09.87595Z","caller":"traceutil/trace.go:171","msg":"trace[1224660824] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"179.5443ms","start":"2026-04-08T06:19:09.696371Z","end":"2026-04-08T06:19:09.875916Z","steps":["trace[1224660824] 'process raft request' (duration: 63.28178ms)","trace[1224660824] 'compare' (duration: 115.815201ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:09.922437Z","caller":"traceutil/trace.go:171","msg":"trace[1555766416] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"221.590617ms","start":"2026-04-08T06:19:09.700817Z","end":"2026-04-08T06:19:09.922408Z","steps":["trace[1555766416] 'process raft request' (duration: 221.495915ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:09.92245Z","caller":"traceutil/trace.go:171","msg":"trace[950391304] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"221.696239ms","start":"2026-04-08T06:19:09.700723Z","end":"2026-04-08T06:19:09.922419Z","steps":["trace[950391304] 'process raft request' (duration: 221.432824ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:09.922574Z","caller":"traceutil/trace.go:171","msg":"trace[209923513] linearizableReadLoop","detail":"{readStateIndex:5418; appliedIndex:5415; }","duration":"157.771766ms","start":"2026-04-08T06:19:09.764782Z","end":"2026-04-08T06:19:09.922554Z","steps":["trace[209923513] 'read index received' (duration: 157.314657ms)","trace[209923513] 'applied index is now lower than readState.Index' (duration: 455.579µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:09.922634Z","caller":"traceutil/trace.go:171","msg":"trace[1537801951] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"197.338485ms","start":"2026-04-08T06:19:09.72528Z","end":"2026-04-08T06:19:09.922619Z","steps":["trace[1537801951] 'process raft request' (duration: 197.08396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:09.922682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.899609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:19:09.923496Z","caller":"traceutil/trace.go:171","msg":"trace[422781724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5228; }","duration":"158.750745ms","start":"2026-04-08T06:19:09.76473Z","end":"2026-04-08T06:19:09.923481Z","steps":["trace[422781724] 'agreement among raft nodes before linearized reading' (duration: 157.881418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:09.923793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.622329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-08T06:19:09.923847Z","caller":"traceutil/trace.go:171","msg":"trace[1402708405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5228; }","duration":"130.67209ms","start":"2026-04-08T06:19:09.793158Z","end":"2026-04-08T06:19:09.92383Z","steps":["trace[1402708405] 'agreement among raft nodes before linearized reading' (duration: 130.537017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:09.92382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.527727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T06:19:09.923984Z","caller":"traceutil/trace.go:171","msg":"trace[1103623142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5228; }","duration":"130.740771ms","start":"2026-04-08T06:19:09.793226Z","end":"2026-04-08T06:19:09.923967Z","steps":["trace[1103623142] 'agreement among raft nodes before linearized reading' (duration: 130.440725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:09.923656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.151828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T06:19:09.924041Z","caller":"traceutil/trace.go:171","msg":"trace[2134698895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5228; }","duration":"132.564706ms","start":"2026-04-08T06:19:09.791461Z","end":"2026-04-08T06:19:09.924025Z","steps":["trace[2134698895] 'agreement among raft nodes before linearized reading' (duration: 132.067777ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:22.20021Z","caller":"traceutil/trace.go:171","msg":"trace[828434058] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"105.809425ms","start":"2026-04-08T06:19:22.094359Z","end":"2026-04-08T06:19:22.200168Z","steps":["trace[828434058] 'process raft request' (duration: 93.166699ms)","trace[828434058] 'compare' (duration: 12.33461ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:22.200674Z","caller":"traceutil/trace.go:171","msg":"trace[1269511600] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"101.577383ms","start":"2026-04-08T06:19:22.099064Z","end":"2026-04-08T06:19:22.200642Z","steps":["trace[1269511600] 'process raft request' (duration: 101.44199ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:22.200722Z","caller":"traceutil/trace.go:171","msg":"trace[526134968] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"104.673974ms","start":"2026-04-08T06:19:22.09603Z","end":"2026-04-08T06:19:22.200704Z","steps":["trace[526134968] 'process raft request' (duration: 104.074332ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:04.918605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2912} {"level":"info","ts":"2026-04-08T06:20:05.003502Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2912,"took":"83.318105ms","hash":2684171290,"current-db-size-bytes":53223424,"current-db-size":"53 MB","current-db-size-in-use-bytes":29384704,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T06:20:05.003568Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2684171290,"revision":2912,"compact-revision":-1} {"level":"info","ts":"2026-04-08T06:25:04.924487Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5645} {"level":"info","ts":"2026-04-08T06:25:04.998882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5645,"took":"72.848685ms","hash":1845380229,"current-db-size-bytes":53223424,"current-db-size":"53 MB","current-db-size-in-use-bytes":18718720,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-04-08T06:25:04.998961Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1845380229,"revision":5645,"compact-revision":2912}