{"level":"warn","ts":"2026-09-01T18:21:36.998897Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T18:21:36.999001Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52: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.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-09-01T18:21:36.999109Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T18:21:36.999131Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-09-01T18:21:36.999148Z","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-09-01T18:21:36.999762Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]} {"level":"info","ts":"2026-09-01T18:21:36.999832Z","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.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-09-01T18:21:37.005392Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.361659ms"} {"level":"info","ts":"2026-09-01T18:21:37.011166Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"} {"level":"info","ts":"2026-09-01T18:21:37.011243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T18:21:37.011264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"} {"level":"info","ts":"2026-09-01T18:21:37.011272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T18:21:37.011284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"} {"level":"info","ts":"2026-09-01T18:21:37.011314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"warn","ts":"2026-09-01T18:21:37.025773Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T18:21:37.029944Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T18:21:37.033737Z","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-09-01T18:21:37.035719Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T18:21:37.036108Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T18:21:37.036293Z","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-09-01T18:21:37.036466Z","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-09-01T18:21:37.036481Z","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-09-01T18:21:37.041136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"info","ts":"2026-09-01T18:21:37.041276Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-09-01T18:21:37.046357Z","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-09-01T18:21:37.046633Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T18:21:37.046668Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T18:21:37.046749Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-09-01T18:21:37.046764Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-09-01T18:21:37.81215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T18:21:37.812255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T18:21:37.812314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"} {"level":"info","ts":"2026-09-01T18:21:37.812336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"} {"level":"info","ts":"2026-09-01T18:21:37.81236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-09-01T18:21:37.812376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"} {"level":"info","ts":"2026-09-01T18:21:37.812397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-09-01T18:21:37.813936Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:21:37.814334Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T18:21:37.814362Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T18:21:37.814345Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T18:21:37.814727Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T18:21:37.814802Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T18:21:37.815011Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:21:37.815219Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:21:37.815275Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T18:21:37.817973Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"} {"level":"info","ts":"2026-09-01T18:21:37.817993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T18:22:22.215851Z","caller":"traceutil/trace.go:171","msg":"trace[379399202] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"349.946319ms","start":"2026-09-01T18:22:21.865878Z","end":"2026-09-01T18:22:22.215824Z","steps":["trace[379399202] 'read index received' (duration: 301.056389ms)","trace[379399202] 'applied index is now lower than readState.Index' (duration: 48.88858ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:22:22.216032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.136534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-z2v8m\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-01T18:22:22.216099Z","caller":"traceutil/trace.go:171","msg":"trace[1222722983] range","detail":"{range_begin:/registry/pods/kube-system/cilium-z2v8m; range_end:; response_count:1; response_revision:633; }","duration":"350.266149ms","start":"2026-09-01T18:22:21.865818Z","end":"2026-09-01T18:22:22.216084Z","steps":["trace[1222722983] 'agreement among raft nodes before linearized reading' (duration: 350.111064ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:22:22.216122Z","caller":"traceutil/trace.go:171","msg":"trace[33965693] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"383.462312ms","start":"2026-09-01T18:22:21.832566Z","end":"2026-09-01T18:22:22.216029Z","steps":["trace[33965693] 'process raft request' (duration: 334.333875ms)","trace[33965693] 'compare' (duration: 48.796648ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:22:22.21613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:21.865787Z","time spent":"350.33545ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-z2v8m\" "} {"level":"warn","ts":"2026-09-01T18:22:22.216994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:21.832544Z","time spent":"383.717961ms","remote":"127.0.0.1:39408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:22:22.65843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.175369ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:22:22.658617Z","caller":"traceutil/trace.go:171","msg":"trace[1886423655] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:633; }","duration":"102.387335ms","start":"2026-09-01T18:22:22.556203Z","end":"2026-09-01T18:22:22.658591Z","steps":["trace[1886423655] 'range keys from in-memory index tree' (duration: 102.156118ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:22:22.659486Z","caller":"traceutil/trace.go:171","msg":"trace[1866116953] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"421.011403ms","start":"2026-09-01T18:22:22.238435Z","end":"2026-09-01T18:22:22.659446Z","steps":["trace[1866116953] 'process raft request' (duration: 419.227292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:22.659743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:22.238401Z","time spent":"421.221609ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T18:22:22.82993Z","caller":"traceutil/trace.go:171","msg":"trace[2092359213] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"261.876419ms","start":"2026-09-01T18:22:22.568016Z","end":"2026-09-01T18:22:22.829892Z","steps":["trace[2092359213] 'read index received' (duration: 89.857481ms)","trace[2092359213] 'applied index is now lower than readState.Index' (duration: 172.017888ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:22:22.829978Z","caller":"traceutil/trace.go:171","msg":"trace[1749620195] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"582.182636ms","start":"2026-09-01T18:22:22.247758Z","end":"2026-09-01T18:22:22.829941Z","steps":["trace[1749620195] 'process raft request' (duration: 580.526568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:22.830127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.053444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:22:22.830195Z","caller":"traceutil/trace.go:171","msg":"trace[1879256678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"262.224189ms","start":"2026-09-01T18:22:22.567955Z","end":"2026-09-01T18:22:22.83018Z","steps":["trace[1879256678] 'agreement among raft nodes before linearized reading' (duration: 262.062285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:22.830258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:22.247717Z","time spent":"582.353451ms","remote":"127.0.0.1:39214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T18:22:37.469943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.147213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T18:22:37.470088Z","caller":"traceutil/trace.go:171","msg":"trace[1066282792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"302.340608ms","start":"2026-09-01T18:22:37.167729Z","end":"2026-09-01T18:22:37.47007Z","steps":["trace[1066282792] 'range keys from in-memory index tree' (duration: 301.976078ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:22:37.470182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:22:37.167705Z","time spent":"302.464551ms","remote":"127.0.0.1:39096","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-09-01T18:23:11.43193Z","caller":"traceutil/trace.go:171","msg":"trace[592019122] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"126.487966ms","start":"2026-09-01T18:23:11.305407Z","end":"2026-09-01T18:23:11.431895Z","steps":["trace[592019122] 'process raft request' (duration: 93.083066ms)","trace[592019122] 'compare' (duration: 33.267656ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:23:11.697397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.158191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:2 size:213491"} {"level":"info","ts":"2026-09-01T18:23:11.69749Z","caller":"traceutil/trace.go:171","msg":"trace[908288047] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:2; response_revision:1236; }","duration":"155.309295ms","start":"2026-09-01T18:23:11.542156Z","end":"2026-09-01T18:23:11.697465Z","steps":["trace[908288047] 'range keys from in-memory index tree' (duration: 154.841401ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:57.084368Z","caller":"traceutil/trace.go:171","msg":"trace[42142505] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"100.149265ms","start":"2026-09-01T18:23:56.984169Z","end":"2026-09-01T18:23:57.084319Z","steps":["trace[42142505] 'process raft request' (duration: 30.525214ms)","trace[42142505] 'compare' (duration: 69.472776ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:23:59.029155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.785555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-01T18:23:59.029226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.884431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-01T18:23:59.029281Z","caller":"traceutil/trace.go:171","msg":"trace[1224630357] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1891; }","duration":"243.002511ms","start":"2026-09-01T18:23:58.786255Z","end":"2026-09-01T18:23:59.029257Z","steps":["trace[1224630357] 'count revisions from in-memory index tree' (duration: 242.59629ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:23:59.029226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.407646ms","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":"warn","ts":"2026-09-01T18:23:59.029339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.088611ms","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-09-01T18:23:59.029803Z","caller":"traceutil/trace.go:171","msg":"trace[1884725567] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1891; }","duration":"112.019385ms","start":"2026-09-01T18:23:58.917742Z","end":"2026-09-01T18:23:59.029762Z","steps":["trace[1884725567] 'range keys from in-memory index tree' (duration: 111.143789ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:59.029458Z","caller":"traceutil/trace.go:171","msg":"trace[882777451] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1891; }","duration":"147.005605ms","start":"2026-09-01T18:23:58.882289Z","end":"2026-09-01T18:23:59.029294Z","steps":["trace[882777451] 'range keys from in-memory index tree' (duration: 146.660335ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:23:59.030508Z","caller":"traceutil/trace.go:171","msg":"trace[896581035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1891; }","duration":"116.565664ms","start":"2026-09-01T18:23:58.913195Z","end":"2026-09-01T18:23:59.029761Z","steps":["trace[896581035] 'range keys from in-memory index tree' (duration: 115.962666ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:24:53.585301Z","caller":"traceutil/trace.go:171","msg":"trace[86114579] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"179.965276ms","start":"2026-09-01T18:24:53.405307Z","end":"2026-09-01T18:24:53.585272Z","steps":["trace[86114579] 'process raft request' (duration: 172.107256ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:24:53.928611Z","caller":"traceutil/trace.go:171","msg":"trace[1444888016] linearizableReadLoop","detail":"{readStateIndex:2329; appliedIndex:2327; }","duration":"191.826538ms","start":"2026-09-01T18:24:53.736752Z","end":"2026-09-01T18:24:53.928579Z","steps":["trace[1444888016] 'read index received' (duration: 189.872583ms)","trace[1444888016] 'applied index is now lower than readState.Index' (duration: 1.953235ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:24:53.928644Z","caller":"traceutil/trace.go:171","msg":"trace[1411194294] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"214.204032ms","start":"2026-09-01T18:24:53.714411Z","end":"2026-09-01T18:24:53.928615Z","steps":["trace[1411194294] 'process raft request' (duration: 212.196046ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:24:53.92877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.978412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T18:24:53.928814Z","caller":"traceutil/trace.go:171","msg":"trace[649042042] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2239; }","duration":"192.059584ms","start":"2026-09-01T18:24:53.736745Z","end":"2026-09-01T18:24:53.928805Z","steps":["trace[649042042] 'agreement among raft nodes before linearized reading' (duration: 191.947241ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:24:53.928818Z","caller":"traceutil/trace.go:171","msg":"trace[502224628] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"211.877176ms","start":"2026-09-01T18:24:53.716914Z","end":"2026-09-01T18:24:53.928792Z","steps":["trace[502224628] 'process raft request' (duration: 211.567438ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:25:34.553966Z","caller":"traceutil/trace.go:171","msg":"trace[639346369] transaction","detail":"{read_only:false; response_revision:2563; number_of_response:1; }","duration":"221.917956ms","start":"2026-09-01T18:25:34.332013Z","end":"2026-09-01T18:25:34.553931Z","steps":["trace[639346369] 'process raft request' (duration: 221.657819ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:25:34.556366Z","caller":"traceutil/trace.go:171","msg":"trace[1819312073] transaction","detail":"{read_only:false; response_revision:2564; number_of_response:1; }","duration":"165.216306ms","start":"2026-09-01T18:25:34.391114Z","end":"2026-09-01T18:25:34.55633Z","steps":["trace[1819312073] 'process raft request' (duration: 164.829185ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:26:07.979429Z","caller":"traceutil/trace.go:171","msg":"trace[189675953] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"166.389402ms","start":"2026-09-01T18:26:07.813016Z","end":"2026-09-01T18:26:07.979406Z","steps":["trace[189675953] 'process raft request' (duration: 166.097904ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:26:08.228208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.086501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:26:08.228362Z","caller":"traceutil/trace.go:171","msg":"trace[1205793601] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"101.662212ms","start":"2026-09-01T18:26:08.126684Z","end":"2026-09-01T18:26:08.228346Z","steps":["trace[1205793601] 'process raft request' (duration: 101.61282ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:26:08.228518Z","caller":"traceutil/trace.go:171","msg":"trace[226016367] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"195.4287ms","start":"2026-09-01T18:26:08.033057Z","end":"2026-09-01T18:26:08.228486Z","steps":["trace[226016367] 'process raft request' (duration: 37.849805ms)","trace[226016367] 'compare' (duration: 156.662348ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:26:08.228636Z","caller":"traceutil/trace.go:171","msg":"trace[1340415422] linearizableReadLoop","detail":"{readStateIndex:2855; appliedIndex:2854; }","duration":"157.07199ms","start":"2026-09-01T18:26:08.071553Z","end":"2026-09-01T18:26:08.228625Z","steps":["trace[1340415422] 'read index received' (duration: 40.082µs)","trace[1340415422] 'applied index is now lower than readState.Index' (duration: 157.030508ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:26:08.229044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.473331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T18:26:08.229074Z","caller":"traceutil/trace.go:171","msg":"trace[1587901755] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2749; }","duration":"157.536252ms","start":"2026-09-01T18:26:08.07153Z","end":"2026-09-01T18:26:08.229066Z","steps":["trace[1587901755] 'agreement among raft nodes before linearized reading' (duration: 157.388798ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:30:58.855242Z","caller":"traceutil/trace.go:171","msg":"trace[1291211465] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"104.31911ms","start":"2026-09-01T18:30:58.750408Z","end":"2026-09-01T18:30:58.854727Z","steps":["trace[1291211465] 'process raft request' (duration: 69.830802ms)","trace[1291211465] 'compare' (duration: 33.776119ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:31:05.156935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.843904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:31:05.157177Z","caller":"traceutil/trace.go:171","msg":"trace[2082012701] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"201.018825ms","start":"2026-09-01T18:31:04.956136Z","end":"2026-09-01T18:31:05.157155Z","steps":["trace[2082012701] 'process raft request' (duration: 50.845202ms)","trace[2082012701] 'compare' (duration: 149.580375ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:31:05.402672Z","caller":"traceutil/trace.go:171","msg":"trace[2095935133] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5164; }","duration":"235.103653ms","start":"2026-09-01T18:31:05.167544Z","end":"2026-09-01T18:31:05.402648Z","steps":["trace[2095935133] 'read index received' (duration: 50.167934ms)","trace[2095935133] 'applied index is now lower than readState.Index' (duration: 184.934109ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T18:31:05.403209Z","caller":"traceutil/trace.go:171","msg":"trace[1044641334] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"238.344594ms","start":"2026-09-01T18:31:05.16485Z","end":"2026-09-01T18:31:05.403195Z","steps":["trace[1044641334] 'process raft request' (duration: 237.323326ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:05.403445Z","caller":"traceutil/trace.go:171","msg":"trace[2015212823] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"238.582352ms","start":"2026-09-01T18:31:05.164839Z","end":"2026-09-01T18:31:05.403421Z","steps":["trace[2015212823] 'process raft request' (duration: 237.656286ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:05.403429Z","caller":"traceutil/trace.go:171","msg":"trace[1697854269] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"239.386674ms","start":"2026-09-01T18:31:05.163948Z","end":"2026-09-01T18:31:05.403335Z","steps":["trace[1697854269] 'process raft request' (duration: 238.040576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:31:05.403906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.323068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-09-01T18:31:05.403961Z","caller":"traceutil/trace.go:171","msg":"trace[645917191] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4973; }","duration":"236.439051ms","start":"2026-09-01T18:31:05.167508Z","end":"2026-09-01T18:31:05.403947Z","steps":["trace[645917191] 'agreement among raft nodes before linearized reading' (duration: 236.223645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:31:05.410243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.978477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-wp78v-tls\" ","response":"range_response_count:1 size:2129"} {"level":"info","ts":"2026-09-01T18:31:05.410307Z","caller":"traceutil/trace.go:171","msg":"trace[1904344795] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-wp78v-tls; range_end:; response_count:1; response_revision:4974; }","duration":"242.0734ms","start":"2026-09-01T18:31:05.168218Z","end":"2026-09-01T18:31:05.410291Z","steps":["trace[1904344795] 'agreement among raft nodes before linearized reading' (duration: 241.827793ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:05.410645Z","caller":"traceutil/trace.go:171","msg":"trace[1205290570] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"155.912686ms","start":"2026-09-01T18:31:05.254714Z","end":"2026-09-01T18:31:05.410626Z","steps":["trace[1205290570] 'process raft request' (duration: 155.208565ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:12.026084Z","caller":"traceutil/trace.go:171","msg":"trace[936921396] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"142.932597ms","start":"2026-09-01T18:31:11.883113Z","end":"2026-09-01T18:31:12.026045Z","steps":["trace[936921396] 'process raft request' (duration: 142.666969ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:12.092261Z","caller":"traceutil/trace.go:171","msg":"trace[1066057949] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"203.692891ms","start":"2026-09-01T18:31:11.888526Z","end":"2026-09-01T18:31:12.092219Z","steps":["trace[1066057949] 'process raft request' (duration: 203.29748ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T18:31:12.092574Z","caller":"traceutil/trace.go:171","msg":"trace[2046009762] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"149.521474ms","start":"2026-09-01T18:31:11.942999Z","end":"2026-09-01T18:31:12.092521Z","steps":["trace[2046009762] 'process raft request' (duration: 149.139693ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T18:31:28.637116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.251292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T18:31:28.637457Z","caller":"traceutil/trace.go:171","msg":"trace[671388139] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"393.314285ms","start":"2026-09-01T18:31:28.244101Z","end":"2026-09-01T18:31:28.637415Z","steps":["trace[671388139] 'process raft request' (duration: 48.63597ms)","trace[671388139] 'compare' (duration: 344.137929ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T18:31:28.637664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:31:28.244058Z","time spent":"393.483889ms","remote":"127.0.0.1:39408","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-09-01T18:31:37.855308Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2905} {"level":"info","ts":"2026-09-01T18:31:37.930341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2905,"took":"73.413195ms","hash":2340971425,"current-db-size-bytes":50491392,"current-db-size":"50 MB","current-db-size-in-use-bytes":27676672,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T18:31:37.930444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2340971425,"revision":2905,"compact-revision":-1} {"level":"info","ts":"2026-09-01T18:36:37.864243Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5380} {"level":"info","ts":"2026-09-01T18:36:37.947925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5380,"took":"82.015276ms","hash":1781290231,"current-db-size-bytes":50491392,"current-db-size":"50 MB","current-db-size-in-use-bytes":18718720,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T18:36:37.948008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1781290231,"revision":5380,"compact-revision":2905}