{"level":"warn","ts":"2026-06-22T01:49:07.596397Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T01:49:07.596493Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-06-22T01:49:07.596574Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T01:49:07.596592Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-22T01:49:07.596614Z","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-06-22T01:49:07.597335Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-06-22T01:49:07.597414Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-06-22T01:49:07.602282Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.479186ms"} {"level":"info","ts":"2026-06-22T01:49:07.610267Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-06-22T01:49:07.610347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T01:49:07.610491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-06-22T01:49:07.610506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T01:49:07.610515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-06-22T01:49:07.610629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-06-22T01:49:07.619333Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T01:49:07.620854Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T01:49:07.621895Z","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-06-22T01:49:07.624025Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T01:49:07.625171Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T01:49:07.625484Z","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-06-22T01:49:07.625557Z","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-06-22T01:49:07.625567Z","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-06-22T01:49:07.629173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-06-22T01:49:07.629292Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-22T01:49:07.630788Z","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-06-22T01:49:07.631655Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-22T01:49:07.631751Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-22T01:49:07.631784Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T01:49:07.631698Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T01:49:07.911164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T01:49:07.911241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T01:49:07.911286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-06-22T01:49:07.911307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-06-22T01:49:07.911317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-22T01:49:07.911335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-06-22T01:49:07.911349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-22T01:49:07.912878Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:07.913649Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:49:07.914044Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T01:49:07.914176Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:07.914192Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T01:49:07.914275Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T01:49:07.914394Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:07.914446Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T01:49:07.918275Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-06-22T01:49:07.918288Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T01:49:07.913594Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T01:49:09.579552Z","caller":"traceutil/trace.go:171","msg":"trace[1551241133] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"234.533311ms","start":"2026-06-22T01:49:09.34498Z","end":"2026-06-22T01:49:09.579513Z","steps":["trace[1551241133] 'read index received' (duration: 234.270988ms)","trace[1551241133] 'applied index is now lower than readState.Index' (duration: 261.093µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:09.579813Z","caller":"traceutil/trace.go:171","msg":"trace[1367201272] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"235.084669ms","start":"2026-06-22T01:49:09.344507Z","end":"2026-06-22T01:49:09.579591Z","steps":["trace[1367201272] 'process raft request' (duration: 234.684634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.579875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.852946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:09.580291Z","caller":"traceutil/trace.go:171","msg":"trace[226335607] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"235.258002ms","start":"2026-06-22T01:49:09.344963Z","end":"2026-06-22T01:49:09.580221Z","steps":["trace[226335607] 'agreement among raft nodes before linearized reading' (duration: 234.766804ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.993037Z","caller":"traceutil/trace.go:171","msg":"trace[1963630963] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"563.434157ms","start":"2026-06-22T01:49:09.429575Z","end":"2026-06-22T01:49:09.993009Z","steps":["trace[1963630963] 'process raft request' (duration: 563.230694ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.993195Z","caller":"traceutil/trace.go:171","msg":"trace[1623617111] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"413.479508ms","start":"2026-06-22T01:49:09.579691Z","end":"2026-06-22T01:49:09.99317Z","steps":["trace[1623617111] 'read index received' (duration: 413.038312ms)","trace[1623617111] 'applied index is now lower than readState.Index' (duration: 440.326µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:09.993258Z","caller":"traceutil/trace.go:171","msg":"trace[665105005] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"563.148263ms","start":"2026-06-22T01:49:09.429993Z","end":"2026-06-22T01:49:09.993141Z","steps":["trace[665105005] 'process raft request' (duration: 563.000001ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.99328Z","caller":"traceutil/trace.go:171","msg":"trace[942368603] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"563.463778ms","start":"2026-06-22T01:49:09.429763Z","end":"2026-06-22T01:49:09.993227Z","steps":["trace[942368603] 'process raft request' (duration: 563.162194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.993391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.042844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:09.993384Z","caller":"traceutil/trace.go:171","msg":"trace[2066387396] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"552.551481ms","start":"2026-06-22T01:49:09.440749Z","end":"2026-06-22T01:49:09.993301Z","steps":["trace[2066387396] 'process raft request' (duration: 552.383029ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.993444Z","caller":"traceutil/trace.go:171","msg":"trace[1247921284] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"563.566989ms","start":"2026-06-22T01:49:09.429863Z","end":"2026-06-22T01:49:09.99343Z","steps":["trace[1247921284] 'process raft request' (duration: 563.090052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.993437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.612592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:09.993487Z","caller":"traceutil/trace.go:171","msg":"trace[247271138] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"563.235844ms","start":"2026-06-22T01:49:09.430226Z","end":"2026-06-22T01:49:09.993462Z","steps":["trace[247271138] 'process raft request' (duration: 562.814708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.993518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.349485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-22T01:49:09.993349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.410996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:09.993598Z","caller":"traceutil/trace.go:171","msg":"trace[304734672] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"512.69586ms","start":"2026-06-22T01:49:09.480886Z","end":"2026-06-22T01:49:09.993582Z","steps":["trace[304734672] 'agreement among raft nodes before linearized reading' (duration: 512.381145ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.993528Z","caller":"traceutil/trace.go:171","msg":"trace[1564790658] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"589.791945ms","start":"2026-06-22T01:49:09.403716Z","end":"2026-06-22T01:49:09.993508Z","steps":["trace[1564790658] 'agreement among raft nodes before linearized reading' (duration: 589.606552ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.99359Z","caller":"traceutil/trace.go:171","msg":"trace[997080735] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"565.441556ms","start":"2026-06-22T01:49:09.428132Z","end":"2026-06-22T01:49:09.993574Z","steps":["trace[997080735] 'agreement among raft nodes before linearized reading' (duration: 565.367545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.993682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.40367Z","time spent":"590.001858ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-22T01:49:09.993429Z","caller":"traceutil/trace.go:171","msg":"trace[1948753527] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"642.093945ms","start":"2026-06-22T01:49:09.351325Z","end":"2026-06-22T01:49:09.993419Z","steps":["trace[1948753527] 'agreement among raft nodes before linearized reading' (duration: 642.048864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.993712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.429552Z","time spent":"563.5897ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:09.993732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.413378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-22T01:49:09.993718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.429804Z","time spent":"563.66823ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:09.993768Z","caller":"traceutil/trace.go:171","msg":"trace[1737555924] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"561.471219ms","start":"2026-06-22T01:49:09.432282Z","end":"2026-06-22T01:49:09.993753Z","steps":["trace[1737555924] 'agreement among raft nodes before linearized reading' (duration: 561.426789ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:09.993767Z","caller":"traceutil/trace.go:171","msg":"trace[612752764] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"563.762041ms","start":"2026-06-22T01:49:09.429993Z","end":"2026-06-22T01:49:09.993755Z","steps":["trace[612752764] 'process raft request' (duration: 563.024441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.993804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.43227Z","time spent":"561.52689ms","remote":"127.0.0.1:52954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-06-22T01:49:09.993837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.429949Z","time spent":"563.858263ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:09.993932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.440734Z","time spent":"552.744283ms","remote":"127.0.0.1:53022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:09.993683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.428112Z","time spent":"565.557628ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T01:49:09.993713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.430216Z","time spent":"563.297755ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:09.994049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.429949Z","time spent":"563.440237ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:09.994135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.472564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-22T01:49:09.994174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.429745Z","time spent":"563.66501ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:09.994182Z","caller":"traceutil/trace.go:171","msg":"trace[266811911] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:0; response_revision:10; }","duration":"567.549176ms","start":"2026-06-22T01:49:09.426622Z","end":"2026-06-22T01:49:09.994171Z","steps":["trace[266811911] 'agreement among raft nodes before linearized reading' (duration: 567.479785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.994214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.426602Z","time spent":"567.605657ms","remote":"127.0.0.1:52882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"warn","ts":"2026-06-22T01:49:09.993726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.351312Z","time spent":"642.405659ms","remote":"127.0.0.1:52910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-22T01:49:09.993647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.48087Z","time spent":"512.76005ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T01:49:09.993474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.239969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:09.993947Z","caller":"traceutil/trace.go:171","msg":"trace[1899707028] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"553.579096ms","start":"2026-06-22T01:49:09.440357Z","end":"2026-06-22T01:49:09.993936Z","steps":["trace[1899707028] 'process raft request' (duration: 552.711744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.994503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.440345Z","time spent":"554.113043ms","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:09.994418Z","caller":"traceutil/trace.go:171","msg":"trace[2050428944] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"399.206263ms","start":"2026-06-22T01:49:09.59519Z","end":"2026-06-22T01:49:09.994396Z","steps":["trace[2050428944] 'agreement among raft nodes before linearized reading' (duration: 398.26878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:09.994614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:09.595166Z","time spent":"399.422867ms","remote":"127.0.0.1:53230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-22T01:49:10.427001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.010243ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-22T01:49:10.427379Z","caller":"traceutil/trace.go:171","msg":"trace[962923531] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"425.885636ms","start":"2026-06-22T01:49:10.001434Z","end":"2026-06-22T01:49:10.42732Z","steps":["trace[962923531] 'process raft request' (duration: 316.302395ms)","trace[962923531] 'compare' (duration: 108.883711ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:49:10.427528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.001391Z","time spent":"426.067507ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.427724Z","caller":"traceutil/trace.go:171","msg":"trace[745422670] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"425.305277ms","start":"2026-06-22T01:49:10.002402Z","end":"2026-06-22T01:49:10.427707Z","steps":["trace[745422670] 'process raft request' (duration: 425.029543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.427799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.002393Z","time spent":"425.381238ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.427573Z","caller":"traceutil/trace.go:171","msg":"trace[498607167] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"425.529131ms","start":"2026-06-22T01:49:10.002013Z","end":"2026-06-22T01:49:10.427542Z","steps":["trace[498607167] 'process raft request' (duration: 425.354628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.427927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.001994Z","time spent":"425.873835ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.42798Z","caller":"traceutil/trace.go:171","msg":"trace[2031289004] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"425.107505ms","start":"2026-06-22T01:49:10.00286Z","end":"2026-06-22T01:49:10.427967Z","steps":["trace[2031289004] 'process raft request' (duration: 424.654818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.42806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.002843Z","time spent":"425.174375ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.428203Z","caller":"traceutil/trace.go:171","msg":"trace[554450202] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"423.462291ms","start":"2026-06-22T01:49:10.004731Z","end":"2026-06-22T01:49:10.428194Z","steps":["trace[554450202] 'process raft request' (duration: 423.017334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.428253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.004717Z","time spent":"423.516041ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.428339Z","caller":"traceutil/trace.go:171","msg":"trace[471846720] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"423.43567ms","start":"2026-06-22T01:49:10.004895Z","end":"2026-06-22T01:49:10.428331Z","steps":["trace[471846720] 'process raft request' (duration: 423.147706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.428379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.004885Z","time spent":"423.477021ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.428432Z","caller":"traceutil/trace.go:171","msg":"trace[384157448] transaction","detail":"{read_only:false; number_of_response:0; response_revision:16; }","duration":"423.657433ms","start":"2026-06-22T01:49:10.004763Z","end":"2026-06-22T01:49:10.42842Z","steps":["trace[384157448] 'process raft request' (duration: 423.244127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.428503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.004737Z","time spent":"423.736435ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T01:49:10.428615Z","caller":"traceutil/trace.go:171","msg":"trace[319760549] linearizableReadLoop","detail":"{readStateIndex:19; appliedIndex:14; }","duration":"423.701274ms","start":"2026-06-22T01:49:10.004775Z","end":"2026-06-22T01:49:10.428476Z","steps":["trace[319760549] 'read index received' (duration: 313.115159ms)","trace[319760549] 'applied index is now lower than readState.Index' (duration: 110.545584ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:10.42875Z","caller":"traceutil/trace.go:171","msg":"trace[896455755] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"423.117855ms","start":"2026-06-22T01:49:10.005622Z","end":"2026-06-22T01:49:10.42874Z","steps":["trace[896455755] 'process raft request' (duration: 422.546187ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:10.428793Z","caller":"traceutil/trace.go:171","msg":"trace[408545105] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"423.055986ms","start":"2026-06-22T01:49:10.005724Z","end":"2026-06-22T01:49:10.42878Z","steps":["trace[408545105] 'process raft request' (duration: 422.510877ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:10.428832Z","caller":"traceutil/trace.go:171","msg":"trace[214453879] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"421.041346ms","start":"2026-06-22T01:49:10.007777Z","end":"2026-06-22T01:49:10.428819Z","steps":["trace[214453879] 'process raft request' (duration: 420.590109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.428917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.428398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.429073Z","caller":"traceutil/trace.go:171","msg":"trace[519620628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"427.60262ms","start":"2026-06-22T01:49:10.00146Z","end":"2026-06-22T01:49:10.429062Z","steps":["trace[519620628] 'agreement among raft nodes before linearized reading' (duration: 427.406837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.42911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.001441Z","time spent":"427.661131ms","remote":"127.0.0.1:52866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T01:49:10.429271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.922641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-b2vlp\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-06-22T01:49:10.429305Z","caller":"traceutil/trace.go:171","msg":"trace[1815577255] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-b2vlp; range_end:; response_count:1; response_revision:20; }","duration":"426.971691ms","start":"2026-06-22T01:49:10.002324Z","end":"2026-06-22T01:49:10.429296Z","steps":["trace[1815577255] 'agreement among raft nodes before linearized reading' (duration: 426.91744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.429361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.002314Z","time spent":"427.041512ms","remote":"127.0.0.1:53112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-b2vlp\" "} {"level":"warn","ts":"2026-06-22T01:49:10.42945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.000538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.429511Z","caller":"traceutil/trace.go:171","msg":"trace[349272843] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"393.096739ms","start":"2026-06-22T01:49:10.0364Z","end":"2026-06-22T01:49:10.429497Z","steps":["trace[349272843] 'agreement among raft nodes before linearized reading' (duration: 392.994817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.429551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.03638Z","time spent":"393.16305ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-06-22T01:49:10.429628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.697568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.42966Z","caller":"traceutil/trace.go:171","msg":"trace[1997802882] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20; }","duration":"101.77578ms","start":"2026-06-22T01:49:10.327875Z","end":"2026-06-22T01:49:10.429651Z","steps":["trace[1997802882] 'agreement among raft nodes before linearized reading' (duration: 101.730739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.429836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.919981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.429881Z","caller":"traceutil/trace.go:171","msg":"trace[2116356898] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:20; }","duration":"101.960532ms","start":"2026-06-22T01:49:10.327904Z","end":"2026-06-22T01:49:10.429865Z","steps":["trace[2116356898] 'agreement among raft nodes before linearized reading' (duration: 101.908011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.429934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.684595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-06-22T01:49:10.42998Z","caller":"traceutil/trace.go:171","msg":"trace[1586268592] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"369.776296ms","start":"2026-06-22T01:49:10.060193Z","end":"2026-06-22T01:49:10.429969Z","steps":["trace[1586268592] 'agreement among raft nodes before linearized reading' (duration: 369.696535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.430015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.060171Z","time spent":"369.837387ms","remote":"127.0.0.1:52968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-22T01:49:10.430101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.427692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.430132Z","caller":"traceutil/trace.go:171","msg":"trace[610779089] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"223.498534ms","start":"2026-06-22T01:49:10.206624Z","end":"2026-06-22T01:49:10.430123Z","steps":["trace[610779089] 'agreement among raft nodes before linearized reading' (duration: 223.458013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.430726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.005677Z","time spent":"423.155148ms","remote":"127.0.0.1:53022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:49:10.428806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.005606Z","time spent":"423.177517ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:10.433427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:10.007767Z","time spent":"421.208069ms","remote":"127.0.0.1:53230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T01:49:10.708981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.663218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-06-22T01:49:10.709124Z","caller":"traceutil/trace.go:171","msg":"trace[1132057050] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"196.369447ms","start":"2026-06-22T01:49:10.51273Z","end":"2026-06-22T01:49:10.709099Z","steps":["trace[1132057050] 'process raft request' (duration: 14.520897ms)","trace[1132057050] 'compare' (duration: 181.571025ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:49:10.709238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.248128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.709265Z","caller":"traceutil/trace.go:171","msg":"trace[47418374] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:53; }","duration":"192.311909ms","start":"2026-06-22T01:49:10.516946Z","end":"2026-06-22T01:49:10.709258Z","steps":["trace[47418374] 'agreement among raft nodes before linearized reading' (duration: 192.195808ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:10.709123Z","caller":"traceutil/trace.go:171","msg":"trace[1072552410] linearizableReadLoop","detail":"{readStateIndex:58; appliedIndex:55; }","duration":"192.124666ms","start":"2026-06-22T01:49:10.516989Z","end":"2026-06-22T01:49:10.709114Z","steps":["trace[1072552410] 'read index received' (duration: 10.242086ms)","trace[1072552410] 'applied index is now lower than readState.Index' (duration: 181.8819ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:10.709365Z","caller":"traceutil/trace.go:171","msg":"trace[960351801] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"192.551503ms","start":"2026-06-22T01:49:10.516806Z","end":"2026-06-22T01:49:10.709358Z","steps":["trace[960351801] 'process raft request' (duration: 192.287239ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:10.709448Z","caller":"traceutil/trace.go:171","msg":"trace[235098526] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"193.223002ms","start":"2026-06-22T01:49:10.516212Z","end":"2026-06-22T01:49:10.709435Z","steps":["trace[235098526] 'process raft request' (duration: 192.849787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:10.709649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.996651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-22T01:49:10.709674Z","caller":"traceutil/trace.go:171","msg":"trace[985119451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:53; }","duration":"177.023691ms","start":"2026-06-22T01:49:10.532644Z","end":"2026-06-22T01:49:10.709668Z","steps":["trace[985119451] 'agreement among raft nodes before linearized reading' (duration: 176.97195ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:11.037227Z","caller":"traceutil/trace.go:171","msg":"trace[1071622213] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"102.708439ms","start":"2026-06-22T01:49:10.93449Z","end":"2026-06-22T01:49:11.037199Z","steps":["trace[1071622213] 'process raft request' (duration: 90.944872ms)","trace[1071622213] 'compare' (duration: 11.439203ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:11.03732Z","caller":"traceutil/trace.go:171","msg":"trace[936398823] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"101.845247ms","start":"2026-06-22T01:49:10.935427Z","end":"2026-06-22T01:49:11.037272Z","steps":["trace[936398823] 'process raft request' (duration: 101.689325ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:15.381689Z","caller":"traceutil/trace.go:171","msg":"trace[2116277887] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"102.852882ms","start":"2026-06-22T01:49:15.278798Z","end":"2026-06-22T01:49:15.381651Z","steps":["trace[2116277887] 'process raft request' (duration: 68.754681ms)","trace[2116277887] 'compare' (duration: 33.820927ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:19.370164Z","caller":"traceutil/trace.go:171","msg":"trace[1287389653] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"108.970335ms","start":"2026-06-22T01:49:19.261172Z","end":"2026-06-22T01:49:19.370142Z","steps":["trace[1287389653] 'process raft request' (duration: 108.671891ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:44.920789Z","caller":"traceutil/trace.go:171","msg":"trace[149678545] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"142.976849ms","start":"2026-06-22T01:49:44.777747Z","end":"2026-06-22T01:49:44.920724Z","steps":["trace[149678545] 'process raft request' (duration: 136.177243ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.062823Z","caller":"traceutil/trace.go:171","msg":"trace[238639589] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"284.797321ms","start":"2026-06-22T01:49:44.778007Z","end":"2026-06-22T01:49:45.062804Z","steps":["trace[238639589] 'process raft request' (duration: 277.968145ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.063119Z","caller":"traceutil/trace.go:171","msg":"trace[1028724610] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"285.006607ms","start":"2026-06-22T01:49:44.778085Z","end":"2026-06-22T01:49:45.063092Z","steps":["trace[1028724610] 'process raft request' (duration: 284.685288ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.063339Z","caller":"traceutil/trace.go:171","msg":"trace[900289837] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"285.260954ms","start":"2026-06-22T01:49:44.778057Z","end":"2026-06-22T01:49:45.063318Z","steps":["trace[900289837] 'process raft request' (duration: 284.961005ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.063584Z","caller":"traceutil/trace.go:171","msg":"trace[81790517] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"282.202596ms","start":"2026-06-22T01:49:44.781336Z","end":"2026-06-22T01:49:45.063538Z","steps":["trace[81790517] 'process raft request' (duration: 281.911398ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.063986Z","caller":"traceutil/trace.go:171","msg":"trace[712330703] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"269.050495ms","start":"2026-06-22T01:49:44.794923Z","end":"2026-06-22T01:49:45.063974Z","steps":["trace[712330703] 'process raft request' (duration: 268.598913ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.064073Z","caller":"traceutil/trace.go:171","msg":"trace[1751133102] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"209.532807ms","start":"2026-06-22T01:49:44.854534Z","end":"2026-06-22T01:49:45.064067Z","steps":["trace[1751133102] 'process raft request' (duration: 209.152046ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:45.063993Z","caller":"traceutil/trace.go:171","msg":"trace[120591118] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"119.571549ms","start":"2026-06-22T01:49:44.944387Z","end":"2026-06-22T01:49:45.063958Z","steps":["trace[120591118] 'process raft request' (duration: 119.480926ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:49.91196Z","caller":"traceutil/trace.go:171","msg":"trace[1889180836] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"286.501636ms","start":"2026-06-22T01:49:49.625439Z","end":"2026-06-22T01:49:49.91194Z","steps":["trace[1889180836] 'read index received' (duration: 286.412454ms)","trace[1889180836] 'applied index is now lower than readState.Index' (duration: 88.032µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:49.912034Z","caller":"traceutil/trace.go:171","msg":"trace[453835053] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"286.758003ms","start":"2026-06-22T01:49:49.625251Z","end":"2026-06-22T01:49:49.912009Z","steps":["trace[453835053] 'process raft request' (duration: 286.531227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.912263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.803755ms","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-06-22T01:49:49.912317Z","caller":"traceutil/trace.go:171","msg":"trace[1216949824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"286.890537ms","start":"2026-06-22T01:49:49.625419Z","end":"2026-06-22T01:49:49.912309Z","steps":["trace[1216949824] 'agreement among raft nodes before linearized reading' (duration: 286.614239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.922432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.770651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.922504Z","caller":"traceutil/trace.go:171","msg":"trace[1718591616] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:619; }","duration":"291.885615ms","start":"2026-06-22T01:49:49.630603Z","end":"2026-06-22T01:49:49.922488Z","steps":["trace[1718591616] 'agreement among raft nodes before linearized reading' (duration: 291.756751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.922498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.327942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.922592Z","caller":"traceutil/trace.go:171","msg":"trace[862250356] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:619; }","duration":"148.478077ms","start":"2026-06-22T01:49:49.774096Z","end":"2026-06-22T01:49:49.922574Z","steps":["trace[862250356] 'agreement among raft nodes before linearized reading' (duration: 148.311142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.922712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.229247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.922741Z","caller":"traceutil/trace.go:171","msg":"trace[30198623] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:619; }","duration":"150.294539ms","start":"2026-06-22T01:49:49.772438Z","end":"2026-06-22T01:49:49.922733Z","steps":["trace[30198623] 'agreement among raft nodes before linearized reading' (duration: 150.252698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.922818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.33668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.922842Z","caller":"traceutil/trace.go:171","msg":"trace[826648127] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:620; }","duration":"150.384351ms","start":"2026-06-22T01:49:49.772446Z","end":"2026-06-22T01:49:49.922831Z","steps":["trace[826648127] 'agreement among raft nodes before linearized reading' (duration: 150.341559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.922934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.437962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.922971Z","caller":"traceutil/trace.go:171","msg":"trace[822176324] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:620; }","duration":"172.475413ms","start":"2026-06-22T01:49:49.75049Z","end":"2026-06-22T01:49:49.922965Z","steps":["trace[822176324] 'agreement among raft nodes before linearized reading' (duration: 172.425402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.797192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923113Z","caller":"traceutil/trace.go:171","msg":"trace[1785419736] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:620; }","duration":"172.833653ms","start":"2026-06-22T01:49:49.750272Z","end":"2026-06-22T01:49:49.923106Z","steps":["trace[1785419736] 'agreement among raft nodes before linearized reading' (duration: 172.791132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.008769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923237Z","caller":"traceutil/trace.go:171","msg":"trace[1271507754] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:620; }","duration":"173.05264ms","start":"2026-06-22T01:49:49.750178Z","end":"2026-06-22T01:49:49.923231Z","steps":["trace[1271507754] 'agreement among raft nodes before linearized reading' (duration: 173.005018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.699155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923355Z","caller":"traceutil/trace.go:171","msg":"trace[1595974958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"183.730916ms","start":"2026-06-22T01:49:49.739619Z","end":"2026-06-22T01:49:49.923349Z","steps":["trace[1595974958] 'agreement among raft nodes before linearized reading' (duration: 183.696065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.841021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923469Z","caller":"traceutil/trace.go:171","msg":"trace[1515091428] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"186.869953ms","start":"2026-06-22T01:49:49.736593Z","end":"2026-06-22T01:49:49.923463Z","steps":["trace[1515091428] 'agreement among raft nodes before linearized reading' (duration: 186.836452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.994665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.92359Z","caller":"traceutil/trace.go:171","msg":"trace[725633367] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"187.038567ms","start":"2026-06-22T01:49:49.736546Z","end":"2026-06-22T01:49:49.923584Z","steps":["trace[725633367] 'agreement among raft nodes before linearized reading' (duration: 187.002726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.92368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.381097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923704Z","caller":"traceutil/trace.go:171","msg":"trace[2100212388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"187.425897ms","start":"2026-06-22T01:49:49.736272Z","end":"2026-06-22T01:49:49.923698Z","steps":["trace[2100212388] 'agreement among raft nodes before linearized reading' (duration: 187.390326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.983119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923816Z","caller":"traceutil/trace.go:171","msg":"trace[1479633763] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"221.004909ms","start":"2026-06-22T01:49:49.702805Z","end":"2026-06-22T01:49:49.92381Z","steps":["trace[1479633763] 'agreement among raft nodes before linearized reading' (duration: 220.974429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.923869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.080751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.923932Z","caller":"traceutil/trace.go:171","msg":"trace[1291028788] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"221.186294ms","start":"2026-06-22T01:49:49.702727Z","end":"2026-06-22T01:49:49.923913Z","steps":["trace[1291028788] 'agreement among raft nodes before linearized reading' (duration: 221.094462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:49.924071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.127879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:49.924971Z","caller":"traceutil/trace.go:171","msg":"trace[1117498753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:620; }","duration":"293.188801ms","start":"2026-06-22T01:49:49.630913Z","end":"2026-06-22T01:49:49.924102Z","steps":["trace[1117498753] 'agreement among raft nodes before linearized reading' (duration: 293.118699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:51.330141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.588097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:49:51.330253Z","caller":"traceutil/trace.go:171","msg":"trace[46512521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"177.738281ms","start":"2026-06-22T01:49:51.152487Z","end":"2026-06-22T01:49:51.330225Z","steps":["trace[46512521] 'range keys from in-memory index tree' (duration: 177.520536ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:51.837383Z","caller":"traceutil/trace.go:171","msg":"trace[2098820445] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"449.993804ms","start":"2026-06-22T01:49:51.387363Z","end":"2026-06-22T01:49:51.837356Z","steps":["trace[2098820445] 'process raft request' (duration: 449.501331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:51.837544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:49:51.387335Z","time spent":"450.137698ms","remote":"127.0.0.1:52962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:49:52.0791Z","caller":"traceutil/trace.go:171","msg":"trace[1577885971] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"227.226396ms","start":"2026-06-22T01:49:51.851852Z","end":"2026-06-22T01:49:52.079078Z","steps":["trace[1577885971] 'process raft request' (duration: 220.043412ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:52.081756Z","caller":"traceutil/trace.go:171","msg":"trace[1067505386] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"229.151689ms","start":"2026-06-22T01:49:51.852577Z","end":"2026-06-22T01:49:52.081728Z","steps":["trace[1067505386] 'process raft request' (duration: 228.942173ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:49:52.081793Z","caller":"traceutil/trace.go:171","msg":"trace[2003252606] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:656; }","duration":"166.441136ms","start":"2026-06-22T01:49:51.915334Z","end":"2026-06-22T01:49:52.081776Z","steps":["trace[2003252606] 'read index received' (duration: 156.640791ms)","trace[2003252606] 'applied index is now lower than readState.Index' (duration: 9.799625ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:49:52.081869Z","caller":"traceutil/trace.go:171","msg":"trace[1417953720] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"190.37424ms","start":"2026-06-22T01:49:51.891489Z","end":"2026-06-22T01:49:52.081863Z","steps":["trace[1417953720] 'process raft request' (duration: 190.160855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:52.082049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.48902ms","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-06-22T01:49:52.08211Z","caller":"traceutil/trace.go:171","msg":"trace[1564528576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"154.575603ms","start":"2026-06-22T01:49:51.927517Z","end":"2026-06-22T01:49:52.082093Z","steps":["trace[1564528576] 'agreement among raft nodes before linearized reading' (duration: 154.405218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:52.082223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.397419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-22T01:49:52.082268Z","caller":"traceutil/trace.go:171","msg":"trace[1552417861] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:634; }","duration":"146.504132ms","start":"2026-06-22T01:49:51.935753Z","end":"2026-06-22T01:49:52.082257Z","steps":["trace[1552417861] 'agreement among raft nodes before linearized reading' (duration: 146.384429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:49:52.082263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.915179ms","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-06-22T01:49:52.082347Z","caller":"traceutil/trace.go:171","msg":"trace[2036215011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"167.027822ms","start":"2026-06-22T01:49:51.915302Z","end":"2026-06-22T01:49:52.08233Z","steps":["trace[2036215011] 'agreement among raft nodes before linearized reading' (duration: 166.770815ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:05.083945Z","caller":"traceutil/trace.go:171","msg":"trace[702418782] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"103.524673ms","start":"2026-06-22T01:50:04.980387Z","end":"2026-06-22T01:50:05.083911Z","steps":["trace[702418782] 'process raft request' (duration: 103.480671ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:05.083991Z","caller":"traceutil/trace.go:171","msg":"trace[185286701] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"104.217711ms","start":"2026-06-22T01:50:04.97974Z","end":"2026-06-22T01:50:05.083957Z","steps":["trace[185286701] 'process raft request' (duration: 104.076777ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:05.084137Z","caller":"traceutil/trace.go:171","msg":"trace[81541373] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"109.293736ms","start":"2026-06-22T01:50:04.974833Z","end":"2026-06-22T01:50:05.084127Z","steps":["trace[81541373] 'process raft request' (duration: 108.854415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:08.678457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.898291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:50:08.678576Z","caller":"traceutil/trace.go:171","msg":"trace[906468857] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"255.519342ms","start":"2026-06-22T01:50:08.423037Z","end":"2026-06-22T01:50:08.678556Z","steps":["trace[906468857] 'read index received' (duration: 42.121µs)","trace[906468857] 'applied index is now lower than readState.Index' (duration: 255.475471ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:50:08.678614Z","caller":"traceutil/trace.go:171","msg":"trace[245814880] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"429.56686ms","start":"2026-06-22T01:50:08.249021Z","end":"2026-06-22T01:50:08.678587Z","steps":["trace[245814880] 'process raft request' (duration: 173.401102ms)","trace[245814880] 'compare' (duration: 255.792929ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:50:08.678737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:50:08.249004Z","time spent":"429.681122ms","remote":"127.0.0.1:53124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:50:08.678743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.706216ms","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-06-22T01:50:08.678801Z","caller":"traceutil/trace.go:171","msg":"trace[2048790625] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:799; }","duration":"255.794048ms","start":"2026-06-22T01:50:08.42299Z","end":"2026-06-22T01:50:08.678785Z","steps":["trace[2048790625] 'agreement among raft nodes before linearized reading' (duration: 255.629144ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:08.785722Z","caller":"traceutil/trace.go:171","msg":"trace[1841888712] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"102.880841ms","start":"2026-06-22T01:50:08.68281Z","end":"2026-06-22T01:50:08.785691Z","steps":["trace[1841888712] 'process raft request' (duration: 100.721829ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:21.49214Z","caller":"traceutil/trace.go:171","msg":"trace[278939859] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:995; }","duration":"340.60043ms","start":"2026-06-22T01:50:21.151517Z","end":"2026-06-22T01:50:21.492118Z","steps":["trace[278939859] 'read index received' (duration: 340.371475ms)","trace[278939859] 'applied index is now lower than readState.Index' (duration: 227.845µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:50:21.492515Z","caller":"traceutil/trace.go:171","msg":"trace[2049169361] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"416.378891ms","start":"2026-06-22T01:50:21.076116Z","end":"2026-06-22T01:50:21.492495Z","steps":["trace[2049169361] 'process raft request' (duration: 415.801948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:21.492613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:50:21.076095Z","time spent":"416.461383ms","remote":"127.0.0.1:53296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T01:50:21.492713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.142702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:50:21.492802Z","caller":"traceutil/trace.go:171","msg":"trace[20621125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"341.352916ms","start":"2026-06-22T01:50:21.151435Z","end":"2026-06-22T01:50:21.492787Z","steps":["trace[20621125] 'agreement among raft nodes before linearized reading' (duration: 341.08484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:21.492784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.855216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-lvjwt\" ","response":"range_response_count:1 size:5676"} {"level":"warn","ts":"2026-06-22T01:50:21.49291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:50:21.151411Z","time spent":"341.445218ms","remote":"127.0.0.1:52868","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-06-22T01:50:21.492919Z","caller":"traceutil/trace.go:171","msg":"trace[1125984297] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-lvjwt; range_end:; response_count:1; response_revision:963; }","duration":"109.03588ms","start":"2026-06-22T01:50:21.383857Z","end":"2026-06-22T01:50:21.492893Z","steps":["trace[1125984297] 'agreement among raft nodes before linearized reading' (duration: 108.711573ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:50:36.37231Z","caller":"traceutil/trace.go:171","msg":"trace[815381214] linearizableReadLoop","detail":"{readStateIndex:1234; appliedIndex:1233; }","duration":"220.623215ms","start":"2026-06-22T01:50:36.151659Z","end":"2026-06-22T01:50:36.372283Z","steps":["trace[815381214] 'read index received' (duration: 220.354088ms)","trace[815381214] 'applied index is now lower than readState.Index' (duration: 268.126µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:50:36.372353Z","caller":"traceutil/trace.go:171","msg":"trace[1549180962] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"252.611108ms","start":"2026-06-22T01:50:36.119711Z","end":"2026-06-22T01:50:36.372322Z","steps":["trace[1549180962] 'process raft request' (duration: 252.390694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:50:36.372501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.816478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T01:50:36.372548Z","caller":"traceutil/trace.go:171","msg":"trace[1768065235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"220.941321ms","start":"2026-06-22T01:50:36.151592Z","end":"2026-06-22T01:50:36.372533Z","steps":["trace[1768065235] 'agreement among raft nodes before linearized reading' (duration: 220.853699ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:14.75417Z","caller":"traceutil/trace.go:171","msg":"trace[406673591] transaction","detail":"{read_only:false; response_revision:1723; number_of_response:1; }","duration":"134.825548ms","start":"2026-06-22T01:51:14.619319Z","end":"2026-06-22T01:51:14.754144Z","steps":["trace[406673591] 'process raft request' (duration: 123.635803ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:14.784438Z","caller":"traceutil/trace.go:171","msg":"trace[909078810] transaction","detail":"{read_only:false; response_revision:1724; number_of_response:1; }","duration":"165.092935ms","start":"2026-06-22T01:51:14.619325Z","end":"2026-06-22T01:51:14.784418Z","steps":["trace[909078810] 'process raft request' (duration: 164.927451ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:14.784771Z","caller":"traceutil/trace.go:171","msg":"trace[1932552701] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"165.395579ms","start":"2026-06-22T01:51:14.619361Z","end":"2026-06-22T01:51:14.784757Z","steps":["trace[1932552701] 'process raft request' (duration: 165.005733ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:14.784826Z","caller":"traceutil/trace.go:171","msg":"trace[719696263] transaction","detail":"{read_only:false; response_revision:1727; number_of_response:1; }","duration":"142.664554ms","start":"2026-06-22T01:51:14.642147Z","end":"2026-06-22T01:51:14.784811Z","steps":["trace[719696263] 'process raft request' (duration: 142.519832ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:14.785176Z","caller":"traceutil/trace.go:171","msg":"trace[1614251088] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"165.804196ms","start":"2026-06-22T01:51:14.61936Z","end":"2026-06-22T01:51:14.785164Z","steps":["trace[1614251088] 'process raft request' (duration: 165.232177ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:23.87704Z","caller":"traceutil/trace.go:171","msg":"trace[911110140] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"156.486209ms","start":"2026-06-22T01:51:23.72052Z","end":"2026-06-22T01:51:23.877006Z","steps":["trace[911110140] 'read index received' (duration: 156.244005ms)","trace[911110140] 'applied index is now lower than readState.Index' (duration: 240.834µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:51:23.877162Z","caller":"traceutil/trace.go:171","msg":"trace[19868616] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"289.086383ms","start":"2026-06-22T01:51:23.588042Z","end":"2026-06-22T01:51:23.877128Z","steps":["trace[19868616] 'process raft request' (duration: 288.809698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:51:23.877453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.907276ms","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-06-22T01:51:23.877549Z","caller":"traceutil/trace.go:171","msg":"trace[1802043913] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1875; }","duration":"157.048378ms","start":"2026-06-22T01:51:23.720481Z","end":"2026-06-22T01:51:23.877529Z","steps":["trace[1802043913] 'agreement among raft nodes before linearized reading' (duration: 156.661862ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:24.14437Z","caller":"traceutil/trace.go:171","msg":"trace[128188622] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"260.591583ms","start":"2026-06-22T01:51:23.88367Z","end":"2026-06-22T01:51:24.144262Z","steps":["trace[128188622] 'process raft request' (duration: 214.148549ms)","trace[128188622] 'compare' (duration: 46.016777ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:51:38.96767Z","caller":"traceutil/trace.go:171","msg":"trace[149588509] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"323.6645ms","start":"2026-06-22T01:51:38.643982Z","end":"2026-06-22T01:51:38.967647Z","steps":["trace[149588509] 'process raft request' (duration: 323.497287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:51:38.967818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:51:38.643959Z","time spent":"323.787573ms","remote":"127.0.0.1:53124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:51:38.969656Z","caller":"traceutil/trace.go:171","msg":"trace[1698184262] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"275.073231ms","start":"2026-06-22T01:51:38.694557Z","end":"2026-06-22T01:51:38.96963Z","steps":["trace[1698184262] 'process raft request' (duration: 274.943649ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:57.41828Z","caller":"traceutil/trace.go:171","msg":"trace[1265954835] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"135.82232ms","start":"2026-06-22T01:51:57.282424Z","end":"2026-06-22T01:51:57.418246Z","steps":["trace[1265954835] 'process raft request' (duration: 135.612935ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:58.23853Z","caller":"traceutil/trace.go:171","msg":"trace[1389793993] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"174.077941ms","start":"2026-06-22T01:51:58.064416Z","end":"2026-06-22T01:51:58.238494Z","steps":["trace[1389793993] 'read index received' (duration: 173.930899ms)","trace[1389793993] 'applied index is now lower than readState.Index' (duration: 146.222µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:51:58.238576Z","caller":"traceutil/trace.go:171","msg":"trace[736037142] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"199.03341ms","start":"2026-06-22T01:51:58.039526Z","end":"2026-06-22T01:51:58.23856Z","steps":["trace[736037142] 'process raft request' (duration: 198.824227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:51:58.238747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.327925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-22T01:51:58.238846Z","caller":"traceutil/trace.go:171","msg":"trace[1581457601] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2113; }","duration":"174.471567ms","start":"2026-06-22T01:51:58.064363Z","end":"2026-06-22T01:51:58.238834Z","steps":["trace[1581457601] 'agreement among raft nodes before linearized reading' (duration: 174.247654ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:58.539568Z","caller":"traceutil/trace.go:171","msg":"trace[1019659716] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"221.080643ms","start":"2026-06-22T01:51:58.318458Z","end":"2026-06-22T01:51:58.539539Z","steps":["trace[1019659716] 'read index received' (duration: 220.988952ms)","trace[1019659716] 'applied index is now lower than readState.Index' (duration: 90.321µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:51:58.539677Z","caller":"traceutil/trace.go:171","msg":"trace[1380514577] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"296.758662ms","start":"2026-06-22T01:51:58.242877Z","end":"2026-06-22T01:51:58.539635Z","steps":["trace[1380514577] 'process raft request' (duration: 296.496038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:51:58.53993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.450209ms","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-06-22T01:51:58.540123Z","caller":"traceutil/trace.go:171","msg":"trace[458564419] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2114; }","duration":"221.630412ms","start":"2026-06-22T01:51:58.318417Z","end":"2026-06-22T01:51:58.540047Z","steps":["trace[458564419] 'agreement among raft nodes before linearized reading' (duration: 221.277536ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:51:58.607303Z","caller":"traceutil/trace.go:171","msg":"trace[1364961000] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"264.756154ms","start":"2026-06-22T01:51:58.342515Z","end":"2026-06-22T01:51:58.607271Z","steps":["trace[1364961000] 'process raft request' (duration: 264.596321ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:52:54.951397Z","caller":"traceutil/trace.go:171","msg":"trace[1081245137] transaction","detail":"{read_only:false; response_revision:2522; number_of_response:1; }","duration":"155.615066ms","start":"2026-06-22T01:52:54.795722Z","end":"2026-06-22T01:52:54.951337Z","steps":["trace[1081245137] 'process raft request' (duration: 155.433803ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:53:32.731428Z","caller":"traceutil/trace.go:171","msg":"trace[647072919] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"137.488527ms","start":"2026-06-22T01:53:32.593913Z","end":"2026-06-22T01:53:32.731402Z","steps":["trace[647072919] 'process raft request' (duration: 137.302364ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:07.70319Z","caller":"traceutil/trace.go:171","msg":"trace[2011381047] transaction","detail":"{read_only:false; response_revision:4494; number_of_response:1; }","duration":"109.765472ms","start":"2026-06-22T01:57:07.5934Z","end":"2026-06-22T01:57:07.703165Z","steps":["trace[2011381047] 'process raft request' (duration: 102.631768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:57:07.703217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.255676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"info","ts":"2026-06-22T01:57:07.703295Z","caller":"traceutil/trace.go:171","msg":"trace[510000378] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4493; }","duration":"120.373558ms","start":"2026-06-22T01:57:07.582901Z","end":"2026-06-22T01:57:07.703275Z","steps":["trace[510000378] 'range keys from in-memory index tree' (duration: 119.480891ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:07.925459Z","caller":"traceutil/trace.go:171","msg":"trace[958959983] transaction","detail":"{read_only:false; response_revision:4495; number_of_response:1; }","duration":"114.094161ms","start":"2026-06-22T01:57:07.811332Z","end":"2026-06-22T01:57:07.925426Z","steps":["trace[958959983] 'process raft request' (duration: 105.837418ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:11.158735Z","caller":"traceutil/trace.go:171","msg":"trace[34829867] transaction","detail":"{read_only:false; response_revision:4552; number_of_response:1; }","duration":"107.676941ms","start":"2026-06-22T01:57:11.051023Z","end":"2026-06-22T01:57:11.1587Z","steps":["trace[34829867] 'process raft request' (duration: 107.371695ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:12.434707Z","caller":"traceutil/trace.go:171","msg":"trace[859932802] transaction","detail":"{read_only:false; response_revision:4599; number_of_response:1; }","duration":"140.584399ms","start":"2026-06-22T01:57:12.294092Z","end":"2026-06-22T01:57:12.434676Z","steps":["trace[859932802] 'process raft request' (duration: 140.255452ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:12.435026Z","caller":"traceutil/trace.go:171","msg":"trace[365552877] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"140.619369ms","start":"2026-06-22T01:57:12.294393Z","end":"2026-06-22T01:57:12.435012Z","steps":["trace[365552877] 'process raft request' (duration: 140.424565ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:18.209976Z","caller":"traceutil/trace.go:171","msg":"trace[1418107203] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"102.312226ms","start":"2026-06-22T01:57:18.107644Z","end":"2026-06-22T01:57:18.209956Z","steps":["trace[1418107203] 'process raft request' (duration: 59.613093ms)","trace[1418107203] 'compare' (duration: 42.599451ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:57:18.494714Z","caller":"traceutil/trace.go:171","msg":"trace[1148332271] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"215.593004ms","start":"2026-06-22T01:57:18.279093Z","end":"2026-06-22T01:57:18.494686Z","steps":["trace[1148332271] 'process raft request' (duration: 215.451122ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:57:18.494865Z","caller":"traceutil/trace.go:171","msg":"trace[1350472756] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"227.622864ms","start":"2026-06-22T01:57:18.26723Z","end":"2026-06-22T01:57:18.494853Z","steps":["trace[1350472756] 'process raft request' (duration: 132.837546ms)","trace[1350472756] 'compare' (duration: 94.252299ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:57:30.869135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.438609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T01:57:30.869249Z","caller":"traceutil/trace.go:171","msg":"trace[1506552524] linearizableReadLoop","detail":"{readStateIndex:5068; appliedIndex:5066; }","duration":"313.41045ms","start":"2026-06-22T01:57:30.555822Z","end":"2026-06-22T01:57:30.869232Z","steps":["trace[1506552524] 'read index received' (duration: 16.304475ms)","trace[1506552524] 'applied index is now lower than readState.Index' (duration: 297.104725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:57:30.869391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.576124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-22T01:57:30.869418Z","caller":"traceutil/trace.go:171","msg":"trace[2069450082] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4886; }","duration":"313.639344ms","start":"2026-06-22T01:57:30.55577Z","end":"2026-06-22T01:57:30.869409Z","steps":["trace[2069450082] 'agreement among raft nodes before linearized reading' (duration: 313.503892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T01:57:30.869447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:57:30.555748Z","time spent":"313.691636ms","remote":"127.0.0.1:53124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-22T01:57:30.869508Z","caller":"traceutil/trace.go:171","msg":"trace[150494392] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"336.03402ms","start":"2026-06-22T01:57:30.533459Z","end":"2026-06-22T01:57:30.869493Z","steps":["trace[150494392] 'process raft request' (duration: 115.152723ms)","trace[150494392] 'compare' (duration: 220.116173ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:57:30.869579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T01:57:30.533436Z","time spent":"336.10724ms","remote":"127.0.0.1:53124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T01:58:23.712591Z","caller":"traceutil/trace.go:171","msg":"trace[998061172] linearizableReadLoop","detail":"{readStateIndex:5521; appliedIndex:5520; }","duration":"105.240014ms","start":"2026-06-22T01:58:23.607328Z","end":"2026-06-22T01:58:23.712568Z","steps":["trace[998061172] 'read index received' (duration: 65.826365ms)","trace[998061172] 'applied index is now lower than readState.Index' (duration: 39.412809ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T01:58:23.713217Z","caller":"traceutil/trace.go:171","msg":"trace[2123034719] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"116.04319ms","start":"2026-06-22T01:58:23.597161Z","end":"2026-06-22T01:58:23.713204Z","steps":["trace[2123034719] 'process raft request' (duration: 76.090472ms)","trace[2123034719] 'compare' (duration: 39.021511ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T01:58:23.713472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.131699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-22T01:58:23.713504Z","caller":"traceutil/trace.go:171","msg":"trace[313020044] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5325; }","duration":"106.20073ms","start":"2026-06-22T01:58:23.607294Z","end":"2026-06-22T01:58:23.713495Z","steps":["trace[313020044] 'agreement among raft nodes before linearized reading' (duration: 106.093948ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T01:59:08.04726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2918} {"level":"info","ts":"2026-06-22T01:59:08.123395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2918,"took":"74.66587ms","hash":471305626,"current-db-size-bytes":53374976,"current-db-size":"53 MB","current-db-size-in-use-bytes":29622272,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-22T01:59:08.123474Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":471305626,"revision":2918,"compact-revision":-1} {"level":"info","ts":"2026-06-22T02:04:08.054019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5659} {"level":"info","ts":"2026-06-22T02:04:08.157597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5659,"took":"101.601099ms","hash":2656531909,"current-db-size-bytes":53374976,"current-db-size":"53 MB","current-db-size-in-use-bytes":18374656,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-22T02:04:08.157701Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2656531909,"revision":5659,"compact-revision":2918}