{"level":"warn","ts":"2026-10-05T01:25:53.443589Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-05T01:25:53.44392Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.73:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.73:2380","--initial-cluster=instance=https://162.253.55.73:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.73:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.73: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-10-05T01:25:53.444041Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-05T01:25:53.447326Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.73:2380"]} {"level":"info","ts":"2026-10-05T01:25:53.447397Z","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-10-05T01:25:53.448209Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"]} {"level":"info","ts":"2026-10-05T01:25:53.448314Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.73:2380"],"listen-peer-urls":["https://162.253.55.73:2380"],"advertise-client-urls":["https://162.253.55.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.73: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-10-05T01:25:53.453141Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.57012ms"} {"level":"info","ts":"2026-10-05T01:25:53.463894Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4c43c9f84c6588d4","cluster-id":"49c90045dbd991f3"} {"level":"info","ts":"2026-10-05T01:25:53.464158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-05T01:25:53.46419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became follower at term 0"} {"level":"info","ts":"2026-10-05T01:25:53.464206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4c43c9f84c6588d4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-05T01:25:53.464214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became follower at term 1"} {"level":"info","ts":"2026-10-05T01:25:53.464258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=(5495458038592932052)"} {"level":"warn","ts":"2026-10-05T01:25:53.470663Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-05T01:25:53.473173Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-05T01:25:53.474753Z","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-10-05T01:25:53.47718Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4c43c9f84c6588d4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-05T01:25:53.47763Z","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-10-05T01:25:53.477698Z","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-10-05T01:25:53.477726Z","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-10-05T01:25:53.477686Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4c43c9f84c6588d4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-05T01:25:53.479259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=(5495458038592932052)"} {"level":"info","ts":"2026-10-05T01:25:53.479458Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49c90045dbd991f3","local-member-id":"4c43c9f84c6588d4","added-peer-id":"4c43c9f84c6588d4","added-peer-peer-urls":["https://162.253.55.73:2380"]} {"level":"info","ts":"2026-10-05T01:25:53.484942Z","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-10-05T01:25:53.485032Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.73:2380"} {"level":"info","ts":"2026-10-05T01:25:53.485073Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.73:2380"} {"level":"info","ts":"2026-10-05T01:25:53.485228Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4c43c9f84c6588d4","initial-advertise-peer-urls":["https://162.253.55.73:2380"],"listen-peer-urls":["https://162.253.55.73:2380"],"advertise-client-urls":["https://162.253.55.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-05T01:25:53.485275Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-05T01:25:54.264465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-05T01:25:54.264529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-05T01:25:54.264568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 received MsgPreVoteResp from 4c43c9f84c6588d4 at term 1"} {"level":"info","ts":"2026-10-05T01:25:54.264582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became candidate at term 2"} {"level":"info","ts":"2026-10-05T01:25:54.264588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 received MsgVoteResp from 4c43c9f84c6588d4 at term 2"} {"level":"info","ts":"2026-10-05T01:25:54.264597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became leader at term 2"} {"level":"info","ts":"2026-10-05T01:25:54.264605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4c43c9f84c6588d4 elected leader 4c43c9f84c6588d4 at term 2"} {"level":"info","ts":"2026-10-05T01:25:54.265685Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4c43c9f84c6588d4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.73:2379]}","request-path":"/0/members/4c43c9f84c6588d4/attributes","cluster-id":"49c90045dbd991f3","publish-timeout":"7s"} {"level":"info","ts":"2026-10-05T01:25:54.2657Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-05T01:25:54.265883Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-05T01:25:54.266106Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-05T01:25:54.266186Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-05T01:25:54.265767Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-05T01:25:54.268209Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49c90045dbd991f3","local-member-id":"4c43c9f84c6588d4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-05T01:25:54.26836Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-05T01:25:54.268398Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-05T01:25:54.269652Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-05T01:25:54.270608Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.73:2379"} {"level":"info","ts":"2026-10-05T01:25:57.430921Z","caller":"traceutil/trace.go:171","msg":"trace[607492693] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"100.803481ms","start":"2026-10-05T01:25:57.330089Z","end":"2026-10-05T01:25:57.430893Z","steps":["trace[607492693] 'process raft request' (duration: 90.841055ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.691225Z","caller":"traceutil/trace.go:171","msg":"trace[78582757] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"122.48915ms","start":"2026-10-05T01:26:35.56872Z","end":"2026-10-05T01:26:35.691209Z","steps":["trace[78582757] 'process raft request' (duration: 122.460189ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.6915Z","caller":"traceutil/trace.go:171","msg":"trace[731282234] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"155.844427ms","start":"2026-10-05T01:26:35.535649Z","end":"2026-10-05T01:26:35.691493Z","steps":["trace[731282234] 'process raft request' (duration: 155.29413ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.691578Z","caller":"traceutil/trace.go:171","msg":"trace[989552977] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"149.747768ms","start":"2026-10-05T01:26:35.541823Z","end":"2026-10-05T01:26:35.691571Z","steps":["trace[989552977] 'process raft request' (duration: 149.213202ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.691643Z","caller":"traceutil/trace.go:171","msg":"trace[444660507] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"140.902213ms","start":"2026-10-05T01:26:35.550735Z","end":"2026-10-05T01:26:35.691638Z","steps":["trace[444660507] 'process raft request' (duration: 140.331505ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.691735Z","caller":"traceutil/trace.go:171","msg":"trace[1174132687] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"140.779698ms","start":"2026-10-05T01:26:35.55095Z","end":"2026-10-05T01:26:35.691729Z","steps":["trace[1174132687] 'process raft request' (duration: 140.148857ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.6918Z","caller":"traceutil/trace.go:171","msg":"trace[1234320767] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"137.513787ms","start":"2026-10-05T01:26:35.554281Z","end":"2026-10-05T01:26:35.691795Z","steps":["trace[1234320767] 'process raft request' (duration: 136.844244ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.691862Z","caller":"traceutil/trace.go:171","msg":"trace[197721160] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"127.069615ms","start":"2026-10-05T01:26:35.564788Z","end":"2026-10-05T01:26:35.691857Z","steps":["trace[197721160] 'process raft request' (duration: 126.364741ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.70478Z","caller":"traceutil/trace.go:171","msg":"trace[516257290] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"116.768799ms","start":"2026-10-05T01:26:35.587989Z","end":"2026-10-05T01:26:35.704758Z","steps":["trace[516257290] 'process raft request' (duration: 116.015552ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.705048Z","caller":"traceutil/trace.go:171","msg":"trace[596855428] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"116.791661ms","start":"2026-10-05T01:26:35.588247Z","end":"2026-10-05T01:26:35.705038Z","steps":["trace[596855428] 'process raft request' (duration: 115.873216ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.705163Z","caller":"traceutil/trace.go:171","msg":"trace[927958325] transaction","detail":"{read_only:false; number_of_response:1; response_revision:508; }","duration":"116.849334ms","start":"2026-10-05T01:26:35.588305Z","end":"2026-10-05T01:26:35.705154Z","steps":["trace[927958325] 'process raft request' (duration: 115.895287ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.705282Z","caller":"traceutil/trace.go:171","msg":"trace[1901773466] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"105.134188ms","start":"2026-10-05T01:26:35.600139Z","end":"2026-10-05T01:26:35.705273Z","steps":["trace[1901773466] 'process raft request' (duration: 104.114528ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.705405Z","caller":"traceutil/trace.go:171","msg":"trace[580060962] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"105.199522ms","start":"2026-10-05T01:26:35.600198Z","end":"2026-10-05T01:26:35.705397Z","steps":["trace[580060962] 'process raft request' (duration: 104.181183ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.892141Z","caller":"traceutil/trace.go:171","msg":"trace[1116522766] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"143.773894ms","start":"2026-10-05T01:26:35.748337Z","end":"2026-10-05T01:26:35.89211Z","steps":["trace[1116522766] 'process raft request' (duration: 49.652626ms)","trace[1116522766] 'compare' (duration: 93.902207ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:26:35.903924Z","caller":"traceutil/trace.go:171","msg":"trace[705484141] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"147.853815ms","start":"2026-10-05T01:26:35.756039Z","end":"2026-10-05T01:26:35.903893Z","steps":["trace[705484141] 'process raft request' (duration: 147.583262ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.904144Z","caller":"traceutil/trace.go:171","msg":"trace[531028317] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"147.898917ms","start":"2026-10-05T01:26:35.756114Z","end":"2026-10-05T01:26:35.904013Z","steps":["trace[531028317] 'process raft request' (duration: 147.653155ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.904274Z","caller":"traceutil/trace.go:171","msg":"trace[1808209166] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:542; }","duration":"146.645735ms","start":"2026-10-05T01:26:35.757556Z","end":"2026-10-05T01:26:35.904201Z","steps":["trace[1808209166] 'read index received' (duration: 40.484046ms)","trace[1808209166] 'applied index is now lower than readState.Index' (duration: 106.160449ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:26:35.906579Z","caller":"traceutil/trace.go:171","msg":"trace[1338178108] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"121.568385ms","start":"2026-10-05T01:26:35.784992Z","end":"2026-10-05T01:26:35.906561Z","steps":["trace[1338178108] 'process raft request' (duration: 118.984708ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:35.907558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.728737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-10-05T01:26:35.907761Z","caller":"traceutil/trace.go:171","msg":"trace[1791355038] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:524; }","duration":"150.180049ms","start":"2026-10-05T01:26:35.757551Z","end":"2026-10-05T01:26:35.907731Z","steps":["trace[1791355038] 'agreement among raft nodes before linearized reading' (duration: 149.340767ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:35.911004Z","caller":"traceutil/trace.go:171","msg":"trace[319979896] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"142.541124ms","start":"2026-10-05T01:26:35.768438Z","end":"2026-10-05T01:26:35.910979Z","steps":["trace[319979896] 'process raft request' (duration: 135.406594ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:35.912071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.494921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-10-05T01:26:35.912104Z","caller":"traceutil/trace.go:171","msg":"trace[1178087510] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:524; }","duration":"154.565363ms","start":"2026-10-05T01:26:35.757529Z","end":"2026-10-05T01:26:35.912095Z","steps":["trace[1178087510] 'agreement among raft nodes before linearized reading' (duration: 154.49419ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:35.912228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.331883ms","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-10-05T01:26:35.912248Z","caller":"traceutil/trace.go:171","msg":"trace[1521744166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:524; }","duration":"132.380656ms","start":"2026-10-05T01:26:35.779862Z","end":"2026-10-05T01:26:35.912242Z","steps":["trace[1521744166] 'agreement among raft nodes before linearized reading' (duration: 132.337794ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:40.924514Z","caller":"traceutil/trace.go:171","msg":"trace[428945277] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"175.42179ms","start":"2026-10-05T01:26:40.74907Z","end":"2026-10-05T01:26:40.924492Z","steps":["trace[428945277] 'process raft request' (duration: 175.043941ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:42.560392Z","caller":"traceutil/trace.go:171","msg":"trace[1874630693] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"328.019593ms","start":"2026-10-05T01:26:42.232343Z","end":"2026-10-05T01:26:42.560363Z","steps":["trace[1874630693] 'read index received' (duration: 327.886877ms)","trace[1874630693] 'applied index is now lower than readState.Index' (duration: 131.666µs)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:26:42.560451Z","caller":"traceutil/trace.go:171","msg":"trace[544965063] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"477.703312ms","start":"2026-10-05T01:26:42.082702Z","end":"2026-10-05T01:26:42.560405Z","steps":["trace[544965063] 'process raft request' (duration: 477.523062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:42.56069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.096311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:26:42.560766Z","caller":"traceutil/trace.go:171","msg":"trace[2020590961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"153.2553ms","start":"2026-10-05T01:26:42.407489Z","end":"2026-10-05T01:26:42.560744Z","steps":["trace[2020590961] 'agreement among raft nodes before linearized reading' (duration: 153.044639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:42.560753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.379292ms","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-10-05T01:26:42.560849Z","caller":"traceutil/trace.go:171","msg":"trace[2037600525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"328.523909ms","start":"2026-10-05T01:26:42.232304Z","end":"2026-10-05T01:26:42.560828Z","steps":["trace[2037600525] 'agreement among raft nodes before linearized reading' (duration: 328.212563ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:42.5609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:26:42.232283Z","time spent":"328.607213ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-05T01:26:42.561277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.826875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-05T01:26:42.561314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:26:42.082672Z","time spent":"477.881801ms","remote":"127.0.0.1:41312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-05T01:26:42.561443Z","caller":"traceutil/trace.go:171","msg":"trace[423899654] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"162.412616ms","start":"2026-10-05T01:26:42.398938Z","end":"2026-10-05T01:26:42.561351Z","steps":["trace[423899654] 'agreement among raft nodes before linearized reading' (duration: 161.757962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:42.561907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.302692ms","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-10-05T01:26:42.561956Z","caller":"traceutil/trace.go:171","msg":"trace[1892471679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"321.367705ms","start":"2026-10-05T01:26:42.240575Z","end":"2026-10-05T01:26:42.561943Z","steps":["trace[1892471679] 'agreement among raft nodes before linearized reading' (duration: 319.954753ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:42.562025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:26:42.240566Z","time spent":"321.449379ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-05T01:26:58.781394Z","caller":"traceutil/trace.go:171","msg":"trace[243550665] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"122.229077ms","start":"2026-10-05T01:26:58.65914Z","end":"2026-10-05T01:26:58.781369Z","steps":["trace[243550665] 'process raft request' (duration: 122.062968ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:58.948309Z","caller":"traceutil/trace.go:171","msg":"trace[879641560] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:804; }","duration":"284.071999ms","start":"2026-10-05T01:26:58.664219Z","end":"2026-10-05T01:26:58.948291Z","steps":["trace[879641560] 'read index received' (duration: 116.989252ms)","trace[879641560] 'applied index is now lower than readState.Index' (duration: 167.081477ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:26:58.948359Z","caller":"traceutil/trace.go:171","msg":"trace[1614679042] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"286.987477ms","start":"2026-10-05T01:26:58.661343Z","end":"2026-10-05T01:26:58.948331Z","steps":["trace[1614679042] 'process raft request' (duration: 286.839799ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:58.948681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.440719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-05T01:26:58.948779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.056308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nmf58\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-05T01:26:58.948787Z","caller":"traceutil/trace.go:171","msg":"trace[1253410948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:776; }","duration":"284.574696ms","start":"2026-10-05T01:26:58.664187Z","end":"2026-10-05T01:26:58.948762Z","steps":["trace[1253410948] 'agreement among raft nodes before linearized reading' (duration: 284.225667ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:26:58.948835Z","caller":"traceutil/trace.go:171","msg":"trace[1499898928] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nmf58; range_end:; response_count:1; response_revision:776; }","duration":"275.107081ms","start":"2026-10-05T01:26:58.673693Z","end":"2026-10-05T01:26:58.948801Z","steps":["trace[1499898928] 'agreement among raft nodes before linearized reading' (duration: 274.735611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:26:58.94871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.500775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:26:58.949063Z","caller":"traceutil/trace.go:171","msg":"trace[1947507462] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:776; }","duration":"166.914597ms","start":"2026-10-05T01:26:58.782133Z","end":"2026-10-05T01:26:58.949047Z","steps":["trace[1947507462] 'agreement among raft nodes before linearized reading' (duration: 166.507225ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:30.330092Z","caller":"traceutil/trace.go:171","msg":"trace[97331649] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"186.268208ms","start":"2026-10-05T01:27:30.143785Z","end":"2026-10-05T01:27:30.330053Z","steps":["trace[97331649] 'process raft request' (duration: 186.046854ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:30.451866Z","caller":"traceutil/trace.go:171","msg":"trace[2071538140] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"116.911981ms","start":"2026-10-05T01:27:30.334912Z","end":"2026-10-05T01:27:30.451824Z","steps":["trace[2071538140] 'process raft request' (duration: 89.014049ms)","trace[2071538140] 'compare' (duration: 27.614895ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:27:52.64326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.012465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-05T01:27:52.643392Z","caller":"traceutil/trace.go:171","msg":"trace[575668829] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"276.875329ms","start":"2026-10-05T01:27:52.36649Z","end":"2026-10-05T01:27:52.643365Z","steps":["trace[575668829] 'process raft request' (duration: 140.16391ms)","trace[575668829] 'compare' (duration: 135.681675ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:27:52.705823Z","caller":"traceutil/trace.go:171","msg":"trace[1246253170] linearizableReadLoop","detail":"{readStateIndex:1429; appliedIndex:1426; }","duration":"297.561778ms","start":"2026-10-05T01:27:52.408242Z","end":"2026-10-05T01:27:52.705804Z","steps":["trace[1246253170] 'read index received' (duration: 98.398088ms)","trace[1246253170] 'applied index is now lower than readState.Index' (duration: 199.16237ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:27:52.705945Z","caller":"traceutil/trace.go:171","msg":"trace[1022673409] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"298.750691ms","start":"2026-10-05T01:27:52.407181Z","end":"2026-10-05T01:27:52.705932Z","steps":["trace[1022673409] 'process raft request' (duration: 298.5762ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:52.70596Z","caller":"traceutil/trace.go:171","msg":"trace[1492339329] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"302.415306ms","start":"2026-10-05T01:27:52.403522Z","end":"2026-10-05T01:27:52.705937Z","steps":["trace[1492339329] 'process raft request' (duration: 302.143069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:27:52.706077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.830994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-05T01:27:52.706081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:27:52.403503Z","time spent":"302.520202ms","remote":"127.0.0.1:41260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1020,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-05T01:27:52.706136Z","caller":"traceutil/trace.go:171","msg":"trace[246181332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1383; }","duration":"297.93425ms","start":"2026-10-05T01:27:52.408187Z","end":"2026-10-05T01:27:52.706122Z","steps":["trace[246181332] 'agreement among raft nodes before linearized reading' (duration: 297.819963ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:52.879372Z","caller":"traceutil/trace.go:171","msg":"trace[1663794827] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"173.444222ms","start":"2026-10-05T01:27:52.705903Z","end":"2026-10-05T01:27:52.879348Z","steps":["trace[1663794827] 'read index received' (duration: 92.941062ms)","trace[1663794827] 'applied index is now lower than readState.Index' (duration: 80.5021ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:27:52.879436Z","caller":"traceutil/trace.go:171","msg":"trace[1233413018] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"229.342402ms","start":"2026-10-05T01:27:52.650058Z","end":"2026-10-05T01:27:52.879401Z","steps":["trace[1233413018] 'process raft request' (duration: 148.79924ms)","trace[1233413018] 'compare' (duration: 80.368272ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:27:52.879563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.304483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-05T01:27:52.879609Z","caller":"traceutil/trace.go:171","msg":"trace[904637931] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1384; }","duration":"283.417569ms","start":"2026-10-05T01:27:52.596178Z","end":"2026-10-05T01:27:52.879595Z","steps":["trace[904637931] 'agreement among raft nodes before linearized reading' (duration: 283.286011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:27:52.879822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.813593ms","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-10-05T01:27:52.879884Z","caller":"traceutil/trace.go:171","msg":"trace[611421445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1384; }","duration":"319.895248ms","start":"2026-10-05T01:27:52.55996Z","end":"2026-10-05T01:27:52.879855Z","steps":["trace[611421445] 'agreement among raft nodes before linearized reading' (duration: 319.682485ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:27:52.879918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:27:52.559948Z","time spent":"319.961253ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-05T01:27:52.879921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.088321ms","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-10-05T01:27:52.880005Z","caller":"traceutil/trace.go:171","msg":"trace[1678433997] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1384; }","duration":"431.202157ms","start":"2026-10-05T01:27:52.448786Z","end":"2026-10-05T01:27:52.879988Z","steps":["trace[1678433997] 'agreement among raft nodes before linearized reading' (duration: 430.956972ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:27:52.88005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:27:52.44877Z","time spent":"431.267391ms","remote":"127.0.0.1:41224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-05T01:27:52.88449Z","caller":"traceutil/trace.go:171","msg":"trace[388592513] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"169.081914ms","start":"2026-10-05T01:27:52.715371Z","end":"2026-10-05T01:27:52.884452Z","steps":["trace[388592513] 'process raft request' (duration: 168.775896ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:52.885102Z","caller":"traceutil/trace.go:171","msg":"trace[534209659] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"169.523021ms","start":"2026-10-05T01:27:52.715562Z","end":"2026-10-05T01:27:52.885085Z","steps":["trace[534209659] 'process raft request' (duration: 168.725262ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:52.885641Z","caller":"traceutil/trace.go:171","msg":"trace[1128481577] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"169.435466ms","start":"2026-10-05T01:27:52.716187Z","end":"2026-10-05T01:27:52.885622Z","steps":["trace[1128481577] 'process raft request' (duration: 168.172419ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:27:52.88666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.532004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:27:52.886751Z","caller":"traceutil/trace.go:171","msg":"trace[1690056348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1388; }","duration":"179.138281ms","start":"2026-10-05T01:27:52.707595Z","end":"2026-10-05T01:27:52.886734Z","steps":["trace[1690056348] 'agreement among raft nodes before linearized reading' (duration: 178.46657ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:27:52.886985Z","caller":"traceutil/trace.go:171","msg":"trace[1148094148] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"170.630729ms","start":"2026-10-05T01:27:52.716343Z","end":"2026-10-05T01:27:52.886974Z","steps":["trace[1148094148] 'process raft request' (duration: 168.701181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:28:22.611938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.526269ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-05T01:28:22.612068Z","caller":"traceutil/trace.go:171","msg":"trace[1465273498] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"358.493568ms","start":"2026-10-05T01:28:22.253557Z","end":"2026-10-05T01:28:22.612051Z","steps":["trace[1465273498] 'read index received' (duration: 138.589295ms)","trace[1465273498] 'applied index is now lower than readState.Index' (duration: 219.903003ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:28:22.61209Z","caller":"traceutil/trace.go:171","msg":"trace[526878414] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"443.089755ms","start":"2026-10-05T01:28:22.168975Z","end":"2026-10-05T01:28:22.612065Z","steps":["trace[526878414] 'process raft request' (duration: 223.195922ms)","trace[526878414] 'compare' (duration: 219.395662ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:28:22.612427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:28:22.16896Z","time spent":"443.312909ms","remote":"127.0.0.1:42296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-05T01:28:22.612605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.99138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-05T01:28:22.612668Z","caller":"traceutil/trace.go:171","msg":"trace[1034394361] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1871; }","duration":"359.144609ms","start":"2026-10-05T01:28:22.253506Z","end":"2026-10-05T01:28:22.612651Z","steps":["trace[1034394361] 'agreement among raft nodes before linearized reading' (duration: 358.634987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:28:22.612827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:28:22.253486Z","time spent":"359.321051ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":29,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-10-05T01:28:22.620226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.580633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:28:22.620294Z","caller":"traceutil/trace.go:171","msg":"trace[1058509328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1872; }","duration":"213.68442ms","start":"2026-10-05T01:28:22.40659Z","end":"2026-10-05T01:28:22.620274Z","steps":["trace[1058509328] 'agreement among raft nodes before linearized reading' (duration: 213.566222ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:28:22.62071Z","caller":"traceutil/trace.go:171","msg":"trace[616165258] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"211.230774ms","start":"2026-10-05T01:28:22.40946Z","end":"2026-10-05T01:28:22.620691Z","steps":["trace[616165258] 'process raft request' (duration: 210.507978ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:28:23.012767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.055658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-05T01:28:23.013116Z","caller":"traceutil/trace.go:171","msg":"trace[834511430] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"378.906381ms","start":"2026-10-05T01:28:22.634112Z","end":"2026-10-05T01:28:23.013018Z","steps":["trace[834511430] 'process raft request' (duration: 250.506641ms)","trace[834511430] 'compare' (duration: 127.910269ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:28:23.013425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-05T01:28:22.634084Z","time spent":"379.185109ms","remote":"127.0.0.1:42296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10966,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-05T01:28:23.028666Z","caller":"traceutil/trace.go:171","msg":"trace[2113659096] linearizableReadLoop","detail":"{readStateIndex:1948; appliedIndex:1946; }","duration":"224.126662ms","start":"2026-10-05T01:28:22.804517Z","end":"2026-10-05T01:28:23.028644Z","steps":["trace[2113659096] 'read index received' (duration: 80.095472ms)","trace[2113659096] 'applied index is now lower than readState.Index' (duration: 144.02893ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:28:23.028824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.278262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-05T01:28:23.028961Z","caller":"traceutil/trace.go:171","msg":"trace[1691032740] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1873; }","duration":"224.464753ms","start":"2026-10-05T01:28:22.804478Z","end":"2026-10-05T01:28:23.028943Z","steps":["trace[1691032740] 'agreement among raft nodes before linearized reading' (duration: 224.263111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:28:23.030245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.734758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bd11b94a-921e-42f9-bcc4-06d3116566ab\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-10-05T01:28:23.030293Z","caller":"traceutil/trace.go:171","msg":"trace[10435427] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bd11b94a-921e-42f9-bcc4-06d3116566ab; range_end:; response_count:1; response_revision:1877; }","duration":"166.808943ms","start":"2026-10-05T01:28:22.863471Z","end":"2026-10-05T01:28:23.03028Z","steps":["trace[10435427] 'agreement among raft nodes before linearized reading' (duration: 166.466761ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:28:35.350293Z","caller":"traceutil/trace.go:171","msg":"trace[480969924] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"171.456769ms","start":"2026-10-05T01:28:35.178809Z","end":"2026-10-05T01:28:35.350266Z","steps":["trace[480969924] 'process raft request' (duration: 171.15701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:28:38.299006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.398803ms","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-10-05T01:28:38.2991Z","caller":"traceutil/trace.go:171","msg":"trace[1265213062] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2010; }","duration":"138.487949ms","start":"2026-10-05T01:28:38.160577Z","end":"2026-10-05T01:28:38.299065Z","steps":["trace[1265213062] 'range keys from in-memory index tree' (duration: 138.192199ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:29:01.685047Z","caller":"traceutil/trace.go:171","msg":"trace[767007983] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"103.129271ms","start":"2026-10-05T01:29:01.581869Z","end":"2026-10-05T01:29:01.684998Z","steps":["trace[767007983] 'process raft request' (duration: 76.520347ms)","trace[767007983] 'compare' (duration: 26.376431ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:29:02.959558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.334365ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-10-05T01:29:02.959955Z","caller":"traceutil/trace.go:171","msg":"trace[675312546] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"150.067391ms","start":"2026-10-05T01:29:02.809865Z","end":"2026-10-05T01:29:02.959933Z","steps":["trace[675312546] 'process raft request' (duration: 149.900636ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:29:02.969895Z","caller":"traceutil/trace.go:171","msg":"trace[1201420378] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"140.575082ms","start":"2026-10-05T01:29:02.829299Z","end":"2026-10-05T01:29:02.969874Z","steps":["trace[1201420378] 'process raft request' (duration: 140.481945ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:29:53.818629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.086142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1313"} {"level":"info","ts":"2026-10-05T01:29:53.818704Z","caller":"traceutil/trace.go:171","msg":"trace[88647179] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2525; }","duration":"231.203131ms","start":"2026-10-05T01:29:53.587485Z","end":"2026-10-05T01:29:53.818688Z","steps":["trace[88647179] 'range keys from in-memory index tree' (duration: 230.935862ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:30:25.431124Z","caller":"traceutil/trace.go:171","msg":"trace[966269197] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"149.756729ms","start":"2026-10-05T01:30:25.281342Z","end":"2026-10-05T01:30:25.431099Z","steps":["trace[966269197] 'process raft request' (duration: 149.520617ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:34:59.373905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.651423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-05T01:34:59.374311Z","caller":"traceutil/trace.go:171","msg":"trace[1605306074] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"261.625535ms","start":"2026-10-05T01:34:59.112651Z","end":"2026-10-05T01:34:59.374277Z","steps":["trace[1605306074] 'process raft request' (duration: 102.485967ms)","trace[1605306074] 'compare' (duration: 158.132357ms)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:34:59.374434Z","caller":"traceutil/trace.go:171","msg":"trace[428780927] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"258.820682ms","start":"2026-10-05T01:34:59.115587Z","end":"2026-10-05T01:34:59.374407Z","steps":["trace[428780927] 'process raft request' (duration: 258.565759ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:34:59.374618Z","caller":"traceutil/trace.go:171","msg":"trace[520871557] linearizableReadLoop","detail":"{readStateIndex:5033; appliedIndex:5029; }","duration":"252.756736ms","start":"2026-10-05T01:34:59.121841Z","end":"2026-10-05T01:34:59.374598Z","steps":["trace[520871557] 'read index received' (duration: 13.385576ms)","trace[520871557] 'applied index is now lower than readState.Index' (duration: 239.36983ms)"],"step_count":2} {"level":"warn","ts":"2026-10-05T01:34:59.374772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.913934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:34:59.374827Z","caller":"traceutil/trace.go:171","msg":"trace[1330982956] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:4844; }","duration":"252.995199ms","start":"2026-10-05T01:34:59.121817Z","end":"2026-10-05T01:34:59.374812Z","steps":["trace[1330982956] 'agreement among raft nodes before linearized reading' (duration: 252.901424ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:34:59.374985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.384598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-10-05T01:34:59.37506Z","caller":"traceutil/trace.go:171","msg":"trace[859024746] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:4844; }","duration":"213.511914ms","start":"2026-10-05T01:34:59.161533Z","end":"2026-10-05T01:34:59.375045Z","steps":["trace[859024746] 'agreement among raft nodes before linearized reading' (duration: 213.245231ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:34:59.37515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.131333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-10-05T01:34:59.375194Z","caller":"traceutil/trace.go:171","msg":"trace[560390499] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4844; }","duration":"189.197486ms","start":"2026-10-05T01:34:59.185983Z","end":"2026-10-05T01:34:59.37518Z","steps":["trace[560390499] 'agreement among raft nodes before linearized reading' (duration: 189.092111ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:34:59.37565Z","caller":"traceutil/trace.go:171","msg":"trace[1407073380] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"258.673685ms","start":"2026-10-05T01:34:59.116958Z","end":"2026-10-05T01:34:59.375632Z","steps":["trace[1407073380] 'process raft request' (duration: 257.312546ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:35:02.442979Z","caller":"traceutil/trace.go:171","msg":"trace[708780111] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"127.676354ms","start":"2026-10-05T01:35:02.315273Z","end":"2026-10-05T01:35:02.442949Z","steps":["trace[708780111] 'process raft request' (duration: 127.498635ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:35:13.564358Z","caller":"traceutil/trace.go:171","msg":"trace[5699542] linearizableReadLoop","detail":"{readStateIndex:5298; appliedIndex:5297; }","duration":"126.979331ms","start":"2026-10-05T01:35:13.437355Z","end":"2026-10-05T01:35:13.564334Z","steps":["trace[5699542] 'read index received' (duration: 126.806422ms)","trace[5699542] 'applied index is now lower than readState.Index' (duration: 171.689µs)"],"step_count":2} {"level":"info","ts":"2026-10-05T01:35:13.564566Z","caller":"traceutil/trace.go:171","msg":"trace[787127347] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"148.186254ms","start":"2026-10-05T01:35:13.416368Z","end":"2026-10-05T01:35:13.564554Z","steps":["trace[787127347] 'process raft request' (duration: 147.798434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:35:13.564633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.084137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:35:13.564724Z","caller":"traceutil/trace.go:171","msg":"trace[1816270476] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:5103; }","duration":"108.187622ms","start":"2026-10-05T01:35:13.456521Z","end":"2026-10-05T01:35:13.564708Z","steps":["trace[1816270476] 'agreement among raft nodes before linearized reading' (duration: 108.057905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:35:13.564902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.54482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-05T01:35:13.56496Z","caller":"traceutil/trace.go:171","msg":"trace[430838279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5103; }","duration":"127.610053ms","start":"2026-10-05T01:35:13.437319Z","end":"2026-10-05T01:35:13.564929Z","steps":["trace[430838279] 'agreement among raft nodes before linearized reading' (duration: 127.561321ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:35:54.302934Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854} {"level":"info","ts":"2026-10-05T01:35:54.403186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"98.385075ms","hash":1461790251,"current-db-size-bytes":53616640,"current-db-size":"54 MB","current-db-size-in-use-bytes":28491776,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-05T01:35:54.403263Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1461790251,"revision":2854,"compact-revision":-1} {"level":"info","ts":"2026-10-05T01:38:57.929375Z","caller":"traceutil/trace.go:171","msg":"trace[1766012724] transaction","detail":"{read_only:false; response_revision:6711; number_of_response:1; }","duration":"108.071816ms","start":"2026-10-05T01:38:57.821276Z","end":"2026-10-05T01:38:57.929347Z","steps":["trace[1766012724] 'process raft request' (duration: 107.903396ms)"],"step_count":1} {"level":"warn","ts":"2026-10-05T01:39:38.817725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.608486ms","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":"warn","ts":"2026-10-05T01:39:38.818129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.418287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-05T01:39:38.818269Z","caller":"traceutil/trace.go:171","msg":"trace[915166364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6977; }","duration":"145.5908ms","start":"2026-10-05T01:39:38.672652Z","end":"2026-10-05T01:39:38.818242Z","steps":["trace[915166364] 'range keys from in-memory index tree' (duration: 144.836551ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:39:38.818385Z","caller":"traceutil/trace.go:171","msg":"trace[2101442830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6977; }","duration":"127.173172ms","start":"2026-10-05T01:39:38.691049Z","end":"2026-10-05T01:39:38.818222Z","steps":["trace[2101442830] 'range keys from in-memory index tree' (duration: 126.346614ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:39:38.946698Z","caller":"traceutil/trace.go:171","msg":"trace[846911036] transaction","detail":"{read_only:false; response_revision:6979; number_of_response:1; }","duration":"121.977466ms","start":"2026-10-05T01:39:38.824697Z","end":"2026-10-05T01:39:38.946674Z","steps":["trace[846911036] 'process raft request' (duration: 116.830351ms)"],"step_count":1} {"level":"info","ts":"2026-10-05T01:40:54.311982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5443} {"level":"info","ts":"2026-10-05T01:40:54.423972Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5443,"took":"110.515602ms","hash":3333600672,"current-db-size-bytes":53616640,"current-db-size":"54 MB","current-db-size-in-use-bytes":18698240,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-05T01:40:54.424048Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3333600672,"revision":5443,"compact-revision":2854}