{"level":"warn","ts":"2026-06-05T06:03:30.712942Z","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-05T06:03:30.713046Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.148: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.148:2380","--initial-cluster=instance=https://199.204.45.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.148: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-05T06:03:30.713127Z","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-05T06:03:30.713152Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-05T06:03:30.713175Z","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-05T06:03:30.713863Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"]} {"level":"info","ts":"2026-06-05T06:03:30.714131Z","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.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.148: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-05T06:03:30.778737Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"64.378595ms"} {"level":"info","ts":"2026-06-05T06:03:30.844357Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8d200b79e0a2e7ca","cluster-id":"908374b13ab3ba47"} {"level":"info","ts":"2026-06-05T06:03:30.844491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T06:03:30.844531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 0"} {"level":"info","ts":"2026-06-05T06:03:30.844551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8d200b79e0a2e7ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T06:03:30.844564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 1"} {"level":"info","ts":"2026-06-05T06:03:30.844621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"warn","ts":"2026-06-05T06:03:30.960687Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T06:03:30.963169Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T06:03:30.965093Z","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-05T06:03:30.968788Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8d200b79e0a2e7ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T06:03:30.968957Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8d200b79e0a2e7ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T06:03:30.96917Z","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-05T06:03:30.969237Z","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-05T06:03:30.969249Z","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-05T06:03:30.96992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"info","ts":"2026-06-05T06:03:30.970164Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","added-peer-id":"8d200b79e0a2e7ca","added-peer-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-05T06:03:30.973379Z","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-05T06:03:30.973748Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8d200b79e0a2e7ca","initial-advertise-peer-urls":["https://199.204.45.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T06:03:30.973795Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T06:03:30.973863Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-05T06:03:30.973894Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-05T06:03:31.845278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T06:03:31.845386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T06:03:31.845424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgPreVoteResp from 8d200b79e0a2e7ca at term 1"} {"level":"info","ts":"2026-06-05T06:03:31.845456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became candidate at term 2"} {"level":"info","ts":"2026-06-05T06:03:31.84547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgVoteResp from 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-05T06:03:31.845497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became leader at term 2"} {"level":"info","ts":"2026-06-05T06:03:31.845548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8d200b79e0a2e7ca elected leader 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-05T06:03:31.846517Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:31.847478Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8d200b79e0a2e7ca","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.148:2379]}","request-path":"/0/members/8d200b79e0a2e7ca/attributes","cluster-id":"908374b13ab3ba47","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T06:03:31.847533Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T06:03:31.847571Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T06:03:31.847964Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:31.848013Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T06:03:31.848057Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T06:03:31.848134Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:31.848209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:31.852808Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T06:03:31.854077Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.148:2379"} {"level":"warn","ts":"2026-06-05T06:03:36.797728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.897369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:03:36.79791Z","caller":"traceutil/trace.go:171","msg":"trace[433437892] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"353.938307ms","start":"2026-06-05T06:03:36.443956Z","end":"2026-06-05T06:03:36.797894Z","steps":["trace[433437892] 'process raft request' (duration: 353.882615ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:36.797919Z","caller":"traceutil/trace.go:171","msg":"trace[1165997529] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"653.239459ms","start":"2026-06-05T06:03:36.144656Z","end":"2026-06-05T06:03:36.797895Z","steps":["trace[1165997529] 'process raft request' (duration: 360.67556ms)","trace[1165997529] 'compare' (duration: 291.749765ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:03:36.79798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.443914Z","time spent":"354.040019ms","remote":"127.0.0.1:37044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T06:03:36.798011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.144637Z","time spent":"653.326102ms","remote":"127.0.0.1:37190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:03:36.798153Z","caller":"traceutil/trace.go:171","msg":"trace[236530999] linearizableReadLoop","detail":"{readStateIndex:283; appliedIndex:282; }","duration":"430.188583ms","start":"2026-06-05T06:03:36.367922Z","end":"2026-06-05T06:03:36.798111Z","steps":["trace[236530999] 'read index received' (duration: 137.521622ms)","trace[236530999] 'applied index is now lower than readState.Index' (duration: 292.660421ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:03:36.798451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.495671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:03:36.798515Z","caller":"traceutil/trace.go:171","msg":"trace[1151958219] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:278; }","duration":"430.620065ms","start":"2026-06-05T06:03:36.367876Z","end":"2026-06-05T06:03:36.798496Z","steps":["trace[1151958219] 'agreement among raft nodes before linearized reading' (duration: 430.414159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:36.798642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.367856Z","time spent":"430.77103ms","remote":"127.0.0.1:37488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"info","ts":"2026-06-05T06:03:36.799267Z","caller":"traceutil/trace.go:171","msg":"trace[1744793308] transaction","detail":"{read_only:false; number_of_response:0; response_revision:278; }","duration":"250.813046ms","start":"2026-06-05T06:03:36.548438Z","end":"2026-06-05T06:03:36.799251Z","steps":["trace[1744793308] 'process raft request' (duration: 250.616631ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:36.799463Z","caller":"traceutil/trace.go:171","msg":"trace[515705305] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"238.048788ms","start":"2026-06-05T06:03:36.561394Z","end":"2026-06-05T06:03:36.799443Z","steps":["trace[515705305] 'process raft request' (duration: 237.866902ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:36.79954Z","caller":"traceutil/trace.go:171","msg":"trace[794156322] transaction","detail":"{read_only:false; number_of_response:0; response_revision:282; }","duration":"238.039557ms","start":"2026-06-05T06:03:36.561491Z","end":"2026-06-05T06:03:36.799531Z","steps":["trace[794156322] 'process raft request' (duration: 237.824301ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:36.799594Z","caller":"traceutil/trace.go:171","msg":"trace[653769711] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"238.722997ms","start":"2026-06-05T06:03:36.56086Z","end":"2026-06-05T06:03:36.799583Z","steps":["trace[653769711] 'process raft request' (duration: 238.311775ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:36.799633Z","caller":"traceutil/trace.go:171","msg":"trace[700407531] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"238.227333ms","start":"2026-06-05T06:03:36.561397Z","end":"2026-06-05T06:03:36.799624Z","steps":["trace[700407531] 'process raft request' (duration: 237.890983ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:36.79971Z","caller":"traceutil/trace.go:171","msg":"trace[2098240484] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"238.597153ms","start":"2026-06-05T06:03:36.561103Z","end":"2026-06-05T06:03:36.7997Z","steps":["trace[2098240484] 'process raft request' (duration: 238.13338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:36.799771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.648827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:03:36.799817Z","caller":"traceutil/trace.go:171","msg":"trace[166917854] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:282; }","duration":"353.71202ms","start":"2026-06-05T06:03:36.446087Z","end":"2026-06-05T06:03:36.799799Z","steps":["trace[166917854] 'agreement among raft nodes before linearized reading' (duration: 353.646718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:36.799874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.44608Z","time spent":"353.786852ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-06-05T06:03:36.800106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.974055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-05T06:03:36.800173Z","caller":"traceutil/trace.go:171","msg":"trace[1390246142] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:282; }","duration":"356.105349ms","start":"2026-06-05T06:03:36.444052Z","end":"2026-06-05T06:03:36.800157Z","steps":["trace[1390246142] 'agreement among raft nodes before linearized reading' (duration: 355.289966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:36.800206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.444032Z","time spent":"356.165481ms","remote":"127.0.0.1:37424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-06-05T06:03:37.145214Z","caller":"traceutil/trace.go:171","msg":"trace[19240080] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"337.780441ms","start":"2026-06-05T06:03:36.807412Z","end":"2026-06-05T06:03:37.145192Z","steps":["trace[19240080] 'process raft request' (duration: 337.73797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:37.145349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.282525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"warn","ts":"2026-06-05T06:03:37.14535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.807403Z","time spent":"337.881524ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:03:37.145308Z","caller":"traceutil/trace.go:171","msg":"trace[1449425069] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"339.424799ms","start":"2026-06-05T06:03:36.80576Z","end":"2026-06-05T06:03:37.145185Z","steps":["trace[1449425069] 'process raft request' (duration: 309.631311ms)","trace[1449425069] 'compare' (duration: 29.540041ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:03:37.145231Z","caller":"traceutil/trace.go:171","msg":"trace[1115812988] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:290; }","duration":"339.153391ms","start":"2026-06-05T06:03:36.806056Z","end":"2026-06-05T06:03:37.14521Z","steps":["trace[1115812988] 'read index received' (duration: 309.286381ms)","trace[1115812988] 'applied index is now lower than readState.Index' (duration: 29.86572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:03:37.145483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.1305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-05T06:03:37.145496Z","caller":"traceutil/trace.go:171","msg":"trace[630274916] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:284; }","duration":"339.153831ms","start":"2026-06-05T06:03:36.806338Z","end":"2026-06-05T06:03:37.145492Z","steps":["trace[630274916] 'agreement among raft nodes before linearized reading' (duration: 339.13019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:37.145512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.806321Z","time spent":"339.186762ms","remote":"127.0.0.1:37086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-05T06:03:37.145375Z","caller":"traceutil/trace.go:171","msg":"trace[858869742] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:284; }","duration":"339.342636ms","start":"2026-06-05T06:03:36.806027Z","end":"2026-06-05T06:03:37.14537Z","steps":["trace[858869742] 'agreement among raft nodes before linearized reading' (duration: 339.242843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:37.145582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.806016Z","time spent":"339.544863ms","remote":"127.0.0.1:37160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4041,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-05T06:03:37.145615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.675546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:03:37.145628Z","caller":"traceutil/trace.go:171","msg":"trace[615334991] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:284; }","duration":"338.701957ms","start":"2026-06-05T06:03:36.806923Z","end":"2026-06-05T06:03:37.145625Z","steps":["trace[615334991] 'agreement among raft nodes before linearized reading' (duration: 338.680077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:37.145641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.806916Z","time spent":"338.721989ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"warn","ts":"2026-06-05T06:03:37.145658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:36.805734Z","time spent":"339.683416ms","remote":"127.0.0.1:37044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:04:08.973242Z","caller":"traceutil/trace.go:171","msg":"trace[724228106] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"134.226127ms","start":"2026-06-05T06:04:08.838991Z","end":"2026-06-05T06:04:08.973217Z","steps":["trace[724228106] 'process raft request' (duration: 36.379678ms)","trace[724228106] 'compare' (duration: 97.729805ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:08.973746Z","caller":"traceutil/trace.go:171","msg":"trace[125287327] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"134.643559ms","start":"2026-06-05T06:04:08.839078Z","end":"2026-06-05T06:04:08.973722Z","steps":["trace[125287327] 'process raft request' (duration: 134.495225ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:08.974076Z","caller":"traceutil/trace.go:171","msg":"trace[1869925022] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"134.892746ms","start":"2026-06-05T06:04:08.839164Z","end":"2026-06-05T06:04:08.974056Z","steps":["trace[1869925022] 'process raft request' (duration: 134.509875ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:08.974368Z","caller":"traceutil/trace.go:171","msg":"trace[1600945849] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"101.898725ms","start":"2026-06-05T06:04:08.872462Z","end":"2026-06-05T06:04:08.97436Z","steps":["trace[1600945849] 'process raft request' (duration: 101.854344ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:08.974494Z","caller":"traceutil/trace.go:171","msg":"trace[879383668] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"120.164912ms","start":"2026-06-05T06:04:08.854322Z","end":"2026-06-05T06:04:08.974486Z","steps":["trace[879383668] 'process raft request' (duration: 119.662317ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:08.974589Z","caller":"traceutil/trace.go:171","msg":"trace[1257215867] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"120.177653ms","start":"2026-06-05T06:04:08.854406Z","end":"2026-06-05T06:04:08.974584Z","steps":["trace[1257215867] 'process raft request' (duration: 119.861524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:14.648058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.654254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:04:14.648169Z","caller":"traceutil/trace.go:171","msg":"trace[1357928466] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"134.412508ms","start":"2026-06-05T06:04:14.513739Z","end":"2026-06-05T06:04:14.648152Z","steps":["trace[1357928466] 'process raft request' (duration: 25.593318ms)","trace[1357928466] 'compare' (duration: 108.496499ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:14.931986Z","caller":"traceutil/trace.go:171","msg":"trace[734673806] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"128.24215ms","start":"2026-06-05T06:04:14.803725Z","end":"2026-06-05T06:04:14.931967Z","steps":["trace[734673806] 'process raft request' (duration: 49.695604ms)","trace[734673806] 'compare' (duration: 78.448634ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:15.606439Z","caller":"traceutil/trace.go:171","msg":"trace[657898494] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"381.505987ms","start":"2026-06-05T06:04:15.224906Z","end":"2026-06-05T06:04:15.606412Z","steps":["trace[657898494] 'process raft request' (duration: 322.056382ms)","trace[657898494] 'compare' (duration: 59.054443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:15.6067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:15.224885Z","time spent":"381.678432ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T06:04:15.606719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.202014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:04:15.606789Z","caller":"traceutil/trace.go:171","msg":"trace[643834729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"193.315107ms","start":"2026-06-05T06:04:15.413457Z","end":"2026-06-05T06:04:15.606772Z","steps":["trace[643834729] 'agreement among raft nodes before linearized reading' (duration: 193.125481ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:15.607116Z","caller":"traceutil/trace.go:171","msg":"trace[291804711] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"192.689899ms","start":"2026-06-05T06:04:15.413527Z","end":"2026-06-05T06:04:15.606217Z","steps":["trace[291804711] 'read index received' (duration: 133.443289ms)","trace[291804711] 'applied index is now lower than readState.Index' (duration: 59.24558ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:15.607312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.951907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-05T06:04:15.607345Z","caller":"traceutil/trace.go:171","msg":"trace[144823492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"176.010458ms","start":"2026-06-05T06:04:15.431322Z","end":"2026-06-05T06:04:15.607332Z","steps":["trace[144823492] 'agreement among raft nodes before linearized reading' (duration: 175.885534ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:15.792035Z","caller":"traceutil/trace.go:171","msg":"trace[154125982] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"174.700131ms","start":"2026-06-05T06:04:15.617316Z","end":"2026-06-05T06:04:15.792016Z","steps":["trace[154125982] 'read index received' (duration: 79.035891ms)","trace[154125982] 'applied index is now lower than readState.Index' (duration: 95.66335ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:15.792117Z","caller":"traceutil/trace.go:171","msg":"trace[2056789705] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"180.22187ms","start":"2026-06-05T06:04:15.611837Z","end":"2026-06-05T06:04:15.792059Z","steps":["trace[2056789705] 'process raft request' (duration: 150.153271ms)","trace[2056789705] 'compare' (duration: 29.819641ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:15.792141Z","caller":"traceutil/trace.go:171","msg":"trace[189296956] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"171.674023ms","start":"2026-06-05T06:04:15.62046Z","end":"2026-06-05T06:04:15.792134Z","steps":["trace[189296956] 'process raft request' (duration: 171.495438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:15.792288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.955939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:04:15.792338Z","caller":"traceutil/trace.go:171","msg":"trace[2056068660] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:637; }","duration":"175.038171ms","start":"2026-06-05T06:04:15.617289Z","end":"2026-06-05T06:04:15.792327Z","steps":["trace[2056068660] 'agreement among raft nodes before linearized reading' (duration: 174.964269ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:32.006193Z","caller":"traceutil/trace.go:171","msg":"trace[1490643070] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"239.287614ms","start":"2026-06-05T06:04:31.766876Z","end":"2026-06-05T06:04:32.006164Z","steps":["trace[1490643070] 'read index received' (duration: 239.246442ms)","trace[1490643070] 'applied index is now lower than readState.Index' (duration: 39.531µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:32.006274Z","caller":"traceutil/trace.go:171","msg":"trace[1486177305] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"314.846434ms","start":"2026-06-05T06:04:31.691387Z","end":"2026-06-05T06:04:32.006234Z","steps":["trace[1486177305] 'process raft request' (duration: 314.596686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:32.006731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:31.691353Z","time spent":"315.008158ms","remote":"127.0.0.1:37166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T06:04:32.008076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.184188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-05T06:04:32.008552Z","caller":"traceutil/trace.go:171","msg":"trace[1984335578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"241.717204ms","start":"2026-06-05T06:04:31.766817Z","end":"2026-06-05T06:04:32.008534Z","steps":["trace[1984335578] 'agreement among raft nodes before linearized reading' (duration: 239.540671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:32.043676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.18829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T06:04:32.043882Z","caller":"traceutil/trace.go:171","msg":"trace[1874279294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"161.413817ms","start":"2026-06-05T06:04:31.882443Z","end":"2026-06-05T06:04:32.043857Z","steps":["trace[1874279294] 'agreement among raft nodes before linearized reading' (duration: 124.058389ms)","trace[1874279294] 'range keys from in-memory index tree' (duration: 37.028159ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:32.043698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.17672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-05T06:04:32.043988Z","caller":"traceutil/trace.go:171","msg":"trace[640210721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"162.497889ms","start":"2026-06-05T06:04:31.881469Z","end":"2026-06-05T06:04:32.043967Z","steps":["trace[640210721] 'agreement among raft nodes before linearized reading' (duration: 125.001587ms)","trace[640210721] 'range keys from in-memory index tree' (duration: 37.09128ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:44.26745Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336536769373097,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T06:04:44.273265Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.027437652s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T06:04:44.273588Z","caller":"traceutil/trace.go:171","msg":"trace[1002510166] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"1.027801153s","start":"2026-06-05T06:04:43.245767Z","end":"2026-06-05T06:04:44.273568Z","steps":["trace[1002510166] 'process raft request' (duration: 1.027639758s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.273729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:43.245756Z","time spent":"1.027893645s","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T06:04:44.319527Z","caller":"traceutil/trace.go:171","msg":"trace[482911082] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:947; }","duration":"599.506096ms","start":"2026-06-05T06:04:43.720001Z","end":"2026-06-05T06:04:44.319507Z","steps":["trace[482911082] 'read index received' (duration: 553.418747ms)","trace[482911082] 'applied index is now lower than readState.Index' (duration: 46.086499ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:44.319638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.632689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:04:44.31962Z","caller":"traceutil/trace.go:171","msg":"trace[1493703840] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"600.810453ms","start":"2026-06-05T06:04:43.718773Z","end":"2026-06-05T06:04:44.319583Z","steps":["trace[1493703840] 'process raft request' (duration: 600.636768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.319769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.1426ms","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-05T06:04:44.319803Z","caller":"traceutil/trace.go:171","msg":"trace[1339793432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:921; }","duration":"204.210192ms","start":"2026-06-05T06:04:44.115586Z","end":"2026-06-05T06:04:44.319796Z","steps":["trace[1339793432] 'agreement among raft nodes before linearized reading' (duration: 204.11576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.319794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:43.718754Z","time spent":"600.937226ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T06:04:44.320045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.166121ms","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-05T06:04:44.320084Z","caller":"traceutil/trace.go:171","msg":"trace[2136439993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:921; }","duration":"204.225602ms","start":"2026-06-05T06:04:44.115848Z","end":"2026-06-05T06:04:44.320074Z","steps":["trace[2136439993] 'agreement among raft nodes before linearized reading' (duration: 204.062378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.320067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.47078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-05T06:04:44.320289Z","caller":"traceutil/trace.go:171","msg":"trace[92509391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:921; }","duration":"203.726328ms","start":"2026-06-05T06:04:44.116537Z","end":"2026-06-05T06:04:44.320263Z","steps":["trace[92509391] 'agreement among raft nodes before linearized reading' (duration: 203.228233ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:44.319661Z","caller":"traceutil/trace.go:171","msg":"trace[1981823182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:921; }","duration":"599.66912ms","start":"2026-06-05T06:04:43.719985Z","end":"2026-06-05T06:04:44.319654Z","steps":["trace[1981823182] 'agreement among raft nodes before linearized reading' (duration: 599.616039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.320432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:43.719756Z","time spent":"600.647299ms","remote":"127.0.0.1:36964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T06:05:36.661735Z","caller":"traceutil/trace.go:171","msg":"trace[2114949455] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1147; }","duration":"155.038566ms","start":"2026-06-05T06:05:36.506673Z","end":"2026-06-05T06:05:36.661712Z","steps":["trace[2114949455] 'read index received' (duration: 154.930092ms)","trace[2114949455] 'applied index is now lower than readState.Index' (duration: 107.484µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:05:36.661784Z","caller":"traceutil/trace.go:171","msg":"trace[1214806064] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"185.292933ms","start":"2026-06-05T06:05:36.476462Z","end":"2026-06-05T06:05:36.661755Z","steps":["trace[1214806064] 'process raft request' (duration: 185.148929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:05:36.661946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.253211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-05T06:05:36.662Z","caller":"traceutil/trace.go:171","msg":"trace[1296181955] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1107; }","duration":"155.372855ms","start":"2026-06-05T06:05:36.506616Z","end":"2026-06-05T06:05:36.661989Z","steps":["trace[1296181955] 'agreement among raft nodes before linearized reading' (duration: 155.202661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:05:37.166852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.461546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:05:37.16694Z","caller":"traceutil/trace.go:171","msg":"trace[577993535] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1112; }","duration":"261.603489ms","start":"2026-06-05T06:05:36.905316Z","end":"2026-06-05T06:05:37.166919Z","steps":["trace[577993535] 'count revisions from in-memory index tree' (duration: 261.336903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:12.671737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.106587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:06:12.671854Z","caller":"traceutil/trace.go:171","msg":"trace[1160399137] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"146.968844ms","start":"2026-06-05T06:06:12.524867Z","end":"2026-06-05T06:06:12.671836Z","steps":["trace[1160399137] 'read index received' (duration: 29.61831ms)","trace[1160399137] 'applied index is now lower than readState.Index' (duration: 117.349264ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:06:12.671946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.070857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:06:12.671978Z","caller":"traceutil/trace.go:171","msg":"trace[33997211] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1298; }","duration":"147.136759ms","start":"2026-06-05T06:06:12.524832Z","end":"2026-06-05T06:06:12.671969Z","steps":["trace[33997211] 'agreement among raft nodes before linearized reading' (duration: 147.060377ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:12.671955Z","caller":"traceutil/trace.go:171","msg":"trace[195456235] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"162.20531ms","start":"2026-06-05T06:06:12.50968Z","end":"2026-06-05T06:06:12.671885Z","steps":["trace[195456235] 'process raft request' (duration: 44.878477ms)","trace[195456235] 'compare' (duration: 116.984144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:06:12.957277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.668079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:06:12.957575Z","caller":"traceutil/trace.go:171","msg":"trace[959330424] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"281.558292ms","start":"2026-06-05T06:06:12.67599Z","end":"2026-06-05T06:06:12.957548Z","steps":["trace[959330424] 'process raft request' (duration: 114.584265ms)","trace[959330424] 'compare' (duration: 166.545335ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:12.957751Z","caller":"traceutil/trace.go:171","msg":"trace[49607271] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1348; }","duration":"116.48527ms","start":"2026-06-05T06:06:12.841248Z","end":"2026-06-05T06:06:12.957733Z","steps":["trace[49607271] 'read index received' (duration: 36.472µs)","trace[49607271] 'applied index is now lower than readState.Index' (duration: 116.447858ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:12.957956Z","caller":"traceutil/trace.go:171","msg":"trace[186015284] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"281.289934ms","start":"2026-06-05T06:06:12.67665Z","end":"2026-06-05T06:06:12.95794Z","steps":["trace[186015284] 'process raft request' (duration: 280.977185ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:12.958001Z","caller":"traceutil/trace.go:171","msg":"trace[1174498132] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"176.572453ms","start":"2026-06-05T06:06:12.781421Z","end":"2026-06-05T06:06:12.957993Z","steps":["trace[1174498132] 'process raft request' (duration: 176.266834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:12.957969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.705727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T06:06:12.958108Z","caller":"traceutil/trace.go:171","msg":"trace[1561279183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1301; }","duration":"116.886382ms","start":"2026-06-05T06:06:12.84121Z","end":"2026-06-05T06:06:12.958096Z","steps":["trace[1561279183] 'agreement among raft nodes before linearized reading' (duration: 116.642095ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:13.078469Z","caller":"traceutil/trace.go:171","msg":"trace[854637446] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"116.811669ms","start":"2026-06-05T06:06:12.961635Z","end":"2026-06-05T06:06:13.078446Z","steps":["trace[854637446] 'process raft request' (duration: 96.198189ms)","trace[854637446] 'compare' (duration: 20.361593ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:13.07851Z","caller":"traceutil/trace.go:171","msg":"trace[2106870286] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"116.425347ms","start":"2026-06-05T06:06:12.962057Z","end":"2026-06-05T06:06:13.078483Z","steps":["trace[2106870286] 'process raft request' (duration: 116.289443ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:13.079299Z","caller":"traceutil/trace.go:171","msg":"trace[651309057] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"116.771607ms","start":"2026-06-05T06:06:12.962516Z","end":"2026-06-05T06:06:13.079287Z","steps":["trace[651309057] 'process raft request' (duration: 115.916533ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:13.079651Z","caller":"traceutil/trace.go:171","msg":"trace[1996783334] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"115.684166ms","start":"2026-06-05T06:06:12.963959Z","end":"2026-06-05T06:06:13.079643Z","steps":["trace[1996783334] 'process raft request' (duration: 115.205072ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:13.079792Z","caller":"traceutil/trace.go:171","msg":"trace[1553651437] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"115.600175ms","start":"2026-06-05T06:06:12.964185Z","end":"2026-06-05T06:06:13.079786Z","steps":["trace[1553651437] 'process raft request' (duration: 115.426229ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:13.079978Z","caller":"traceutil/trace.go:171","msg":"trace[1323217178] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"115.11821ms","start":"2026-06-05T06:06:12.964852Z","end":"2026-06-05T06:06:13.079971Z","steps":["trace[1323217178] 'process raft request' (duration: 114.908774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:25.162647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.342027ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:06:25.162798Z","caller":"traceutil/trace.go:171","msg":"trace[1812137648] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"168.369486ms","start":"2026-06-05T06:06:24.994385Z","end":"2026-06-05T06:06:25.162754Z","steps":["trace[1812137648] 'process raft request' (duration: 23.797293ms)","trace[1812137648] 'compare' (duration: 144.219013ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:25.399508Z","caller":"traceutil/trace.go:171","msg":"trace[1088526090] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"232.816779ms","start":"2026-06-05T06:06:25.166664Z","end":"2026-06-05T06:06:25.399481Z","steps":["trace[1088526090] 'process raft request' (duration: 232.651344ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:25.400952Z","caller":"traceutil/trace.go:171","msg":"trace[1068353952] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1436; }","duration":"207.394858ms","start":"2026-06-05T06:06:25.193541Z","end":"2026-06-05T06:06:25.400936Z","steps":["trace[1068353952] 'read index received' (duration: 205.784331ms)","trace[1068353952] 'applied index is now lower than readState.Index' (duration: 1.609547ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:25.400989Z","caller":"traceutil/trace.go:171","msg":"trace[1786900948] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"234.235279ms","start":"2026-06-05T06:06:25.166741Z","end":"2026-06-05T06:06:25.400976Z","steps":["trace[1786900948] 'process raft request' (duration: 234.038463ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:25.400997Z","caller":"traceutil/trace.go:171","msg":"trace[1979548152] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"233.623503ms","start":"2026-06-05T06:06:25.167335Z","end":"2026-06-05T06:06:25.400958Z","steps":["trace[1979548152] 'process raft request' (duration: 233.53142ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:25.401064Z","caller":"traceutil/trace.go:171","msg":"trace[833011777] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"233.186819ms","start":"2026-06-05T06:06:25.16786Z","end":"2026-06-05T06:06:25.401047Z","steps":["trace[833011777] 'process raft request' (duration: 233.043195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:25.401194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.635435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-05T06:06:25.401235Z","caller":"traceutil/trace.go:171","msg":"trace[913647926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1388; }","duration":"207.710777ms","start":"2026-06-05T06:06:25.193514Z","end":"2026-06-05T06:06:25.401225Z","steps":["trace[913647926] 'agreement among raft nodes before linearized reading' (duration: 207.570173ms)"],"step_count":1}