{"level":"warn","ts":"2026-04-19T13:30:46.808847Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T13:30:46.808951Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-19T13:30:46.809054Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T13:30:46.809067Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-19T13:30:46.809099Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-19T13:30:46.80991Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-04-19T13:30:46.81Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-19T13:30:46.818747Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.530653ms"} {"level":"info","ts":"2026-04-19T13:30:46.838223Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-04-19T13:30:46.838375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-04-19T13:30:46.838425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-04-19T13:30:46.838453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-19T13:30:46.838482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-04-19T13:30:46.838539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-04-19T13:30:46.852171Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-19T13:30:46.862485Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-19T13:30:46.863911Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-19T13:30:46.868235Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-19T13:30:46.868549Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-19T13:30:46.868626Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:30:46.869001Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:30:46.86904Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-19T13:30:46.871322Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-19T13:30:46.87165Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-19T13:30:46.871691Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-19T13:30:46.87186Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-19T13:30:46.871884Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-19T13:30:46.873278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-04-19T13:30:46.87351Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-19T13:30:47.439367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-04-19T13:30:47.439446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-19T13:30:47.439472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-04-19T13:30:47.439491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-04-19T13:30:47.439506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-19T13:30:47.439526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-04-19T13:30:47.439543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-19T13:30:47.440412Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:30:47.441378Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T13:30:47.441373Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-04-19T13:30:47.441664Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T13:30:47.445337Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-19T13:30:47.445513Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-04-19T13:30:47.448943Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:30:47.449284Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:30:47.449331Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T13:30:47.44936Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-19T13:30:47.449377Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-19T13:31:02.56724Z","caller":"traceutil/trace.go:171","msg":"trace[1659623043] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"167.655658ms","start":"2026-04-19T13:31:02.399547Z","end":"2026-04-19T13:31:02.567203Z","steps":["trace[1659623043] 'process raft request' (duration: 167.462814ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:03.036297Z","caller":"traceutil/trace.go:171","msg":"trace[2020190087] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"118.385395ms","start":"2026-04-19T13:31:02.917889Z","end":"2026-04-19T13:31:03.036275Z","steps":["trace[2020190087] 'read index received' (duration: 118.258522ms)","trace[2020190087] 'applied index is now lower than readState.Index' (duration: 125.943µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:31:03.036414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.515287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:31:03.036477Z","caller":"traceutil/trace.go:171","msg":"trace[185902130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:412; }","duration":"118.62549ms","start":"2026-04-19T13:31:02.917842Z","end":"2026-04-19T13:31:03.036467Z","steps":["trace[185902130] 'agreement among raft nodes before linearized reading' (duration: 118.510777ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:03.03661Z","caller":"traceutil/trace.go:171","msg":"trace[1156083776] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"275.53998ms","start":"2026-04-19T13:31:02.760919Z","end":"2026-04-19T13:31:03.036459Z","steps":["trace[1156083776] 'process raft request' (duration: 275.232143ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:03.166095Z","caller":"traceutil/trace.go:171","msg":"trace[961427438] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"125.637599ms","start":"2026-04-19T13:31:03.040432Z","end":"2026-04-19T13:31:03.16607Z","steps":["trace[961427438] 'process raft request' (duration: 120.882784ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:19.643713Z","caller":"traceutil/trace.go:171","msg":"trace[817243563] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"128.522648ms","start":"2026-04-19T13:31:19.515173Z","end":"2026-04-19T13:31:19.643695Z","steps":["trace[817243563] 'process raft request' (duration: 128.432025ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:23.799846Z","caller":"traceutil/trace.go:171","msg":"trace[125946272] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"123.820545ms","start":"2026-04-19T13:31:23.675993Z","end":"2026-04-19T13:31:23.799813Z","steps":["trace[125946272] 'process raft request' (duration: 123.690122ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:23.802999Z","caller":"traceutil/trace.go:171","msg":"trace[1539070072] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"126.722404ms","start":"2026-04-19T13:31:23.676254Z","end":"2026-04-19T13:31:23.802977Z","steps":["trace[1539070072] 'process raft request' (duration: 126.476688ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:31:24.155305Z","caller":"traceutil/trace.go:171","msg":"trace[2130719317] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"162.726829ms","start":"2026-04-19T13:31:23.99255Z","end":"2026-04-19T13:31:24.155276Z","steps":["trace[2130719317] 'process raft request' (duration: 162.168596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:31:24.641423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.270551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kmhx6\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-19T13:31:24.641601Z","caller":"traceutil/trace.go:171","msg":"trace[2010847186] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kmhx6; range_end:; response_count:1; response_revision:618; }","duration":"190.483197ms","start":"2026-04-19T13:31:24.451096Z","end":"2026-04-19T13:31:24.641579Z","steps":["trace[2010847186] 'range keys from in-memory index tree' (duration: 190.116478ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:15.645309Z","caller":"traceutil/trace.go:171","msg":"trace[1282959450] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"133.750134ms","start":"2026-04-19T13:32:15.511478Z","end":"2026-04-19T13:32:15.645228Z","steps":["trace[1282959450] 'process raft request' (duration: 132.873353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:15.948581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.393257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:32:15.948843Z","caller":"traceutil/trace.go:171","msg":"trace[1966433486] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"299.569751ms","start":"2026-04-19T13:32:15.649219Z","end":"2026-04-19T13:32:15.948789Z","steps":["trace[1966433486] 'process raft request' (duration: 187.342403ms)","trace[1966433486] 'compare' (duration: 110.827943ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:32:15.949098Z","caller":"traceutil/trace.go:171","msg":"trace[1819734485] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"161.072402ms","start":"2026-04-19T13:32:15.787997Z","end":"2026-04-19T13:32:15.94907Z","steps":["trace[1819734485] 'process raft request' (duration: 160.718504ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:40.022878Z","caller":"traceutil/trace.go:171","msg":"trace[580623768] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1114; }","duration":"142.984307ms","start":"2026-04-19T13:32:39.879872Z","end":"2026-04-19T13:32:40.022856Z","steps":["trace[580623768] 'read index received' (duration: 142.794232ms)","trace[580623768] 'applied index is now lower than readState.Index' (duration: 189.275µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:32:40.023007Z","caller":"traceutil/trace.go:171","msg":"trace[321230246] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"270.534273ms","start":"2026-04-19T13:32:39.752429Z","end":"2026-04-19T13:32:40.022963Z","steps":["trace[321230246] 'process raft request' (duration: 270.291807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:40.023088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.193992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:32:40.023144Z","caller":"traceutil/trace.go:171","msg":"trace[463654870] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1074; }","duration":"143.331497ms","start":"2026-04-19T13:32:39.879799Z","end":"2026-04-19T13:32:40.023131Z","steps":["trace[463654870] 'agreement among raft nodes before linearized reading' (duration: 143.219333ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:54.333944Z","caller":"traceutil/trace.go:171","msg":"trace[652305167] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"253.333809ms","start":"2026-04-19T13:32:54.080589Z","end":"2026-04-19T13:32:54.333922Z","steps":["trace[652305167] 'process raft request' (duration: 253.214136ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:54.334439Z","caller":"traceutil/trace.go:171","msg":"trace[1300809944] linearizableReadLoop","detail":"{readStateIndex:1217; appliedIndex:1217; }","duration":"160.923568ms","start":"2026-04-19T13:32:54.173468Z","end":"2026-04-19T13:32:54.334391Z","steps":["trace[1300809944] 'read index received' (duration: 160.908167ms)","trace[1300809944] 'applied index is now lower than readState.Index' (duration: 12.991µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:32:54.334621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.127242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T13:32:54.334668Z","caller":"traceutil/trace.go:171","msg":"trace[121829124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1172; }","duration":"161.230995ms","start":"2026-04-19T13:32:54.173426Z","end":"2026-04-19T13:32:54.334657Z","steps":["trace[121829124] 'agreement among raft nodes before linearized reading' (duration: 161.125833ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:32:54.425238Z","caller":"traceutil/trace.go:171","msg":"trace[417844000] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"240.87728ms","start":"2026-04-19T13:32:54.184334Z","end":"2026-04-19T13:32:54.425212Z","steps":["trace[417844000] 'process raft request' (duration: 185.650333ms)","trace[417844000] 'compare' (duration: 54.944941ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:32:54.425258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.225511ms","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-04-19T13:32:54.425329Z","caller":"traceutil/trace.go:171","msg":"trace[1002959671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1173; }","duration":"197.348955ms","start":"2026-04-19T13:32:54.227961Z","end":"2026-04-19T13:32:54.42531Z","steps":["trace[1002959671] 'agreement among raft nodes before linearized reading' (duration: 197.1473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:32:54.425729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.891952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-19T13:32:54.425821Z","caller":"traceutil/trace.go:171","msg":"trace[210606344] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1173; }","duration":"110.2336ms","start":"2026-04-19T13:32:54.315569Z","end":"2026-04-19T13:32:54.425803Z","steps":["trace[210606344] 'agreement among raft nodes before linearized reading' (duration: 109.538594ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:12.198635Z","caller":"traceutil/trace.go:171","msg":"trace[1557600143] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"122.965976ms","start":"2026-04-19T13:33:12.075645Z","end":"2026-04-19T13:33:12.198611Z","steps":["trace[1557600143] 'process raft request' (duration: 122.805312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:12.565845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.92721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-19T13:33:12.565954Z","caller":"traceutil/trace.go:171","msg":"trace[1634339042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1251; }","duration":"149.113684ms","start":"2026-04-19T13:33:12.416814Z","end":"2026-04-19T13:33:12.565928Z","steps":["trace[1634339042] 'range keys from in-memory index tree' (duration: 148.664874ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:26.984897Z","caller":"traceutil/trace.go:171","msg":"trace[460836027] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1402; }","duration":"326.316185ms","start":"2026-04-19T13:33:26.658557Z","end":"2026-04-19T13:33:26.984873Z","steps":["trace[460836027] 'read index received' (duration: 326.12141ms)","trace[460836027] 'applied index is now lower than readState.Index' (duration: 193.855µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:33:26.985031Z","caller":"traceutil/trace.go:171","msg":"trace[863054600] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"360.372153ms","start":"2026-04-19T13:33:26.624592Z","end":"2026-04-19T13:33:26.984964Z","steps":["trace[863054600] 'process raft request' (duration: 360.138537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:26.985148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.56763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-19T13:33:26.985229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:33:26.624571Z","time spent":"360.563518ms","remote":"127.0.0.1:45728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T13:33:26.985221Z","caller":"traceutil/trace.go:171","msg":"trace[1103256677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1350; }","duration":"326.685774ms","start":"2026-04-19T13:33:26.658524Z","end":"2026-04-19T13:33:26.98521Z","steps":["trace[1103256677] 'agreement among raft nodes before linearized reading' (duration: 326.497429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:26.985306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.474243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T13:33:26.985332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.486941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-19T13:33:26.985335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.340831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T13:33:26.985405Z","caller":"traceutil/trace.go:171","msg":"trace[39867889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1350; }","duration":"272.603774ms","start":"2026-04-19T13:33:26.712784Z","end":"2026-04-19T13:33:26.985388Z","steps":["trace[39867889] 'agreement among raft nodes before linearized reading' (duration: 272.383978ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:26.985418Z","caller":"traceutil/trace.go:171","msg":"trace[123558904] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1350; }","duration":"273.487195ms","start":"2026-04-19T13:33:26.711917Z","end":"2026-04-19T13:33:26.985404Z","steps":["trace[123558904] 'agreement among raft nodes before linearized reading' (duration: 273.262959ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:26.985362Z","caller":"traceutil/trace.go:171","msg":"trace[1322918265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1350; }","duration":"268.558816ms","start":"2026-04-19T13:33:26.716785Z","end":"2026-04-19T13:33:26.985344Z","steps":["trace[1322918265] 'agreement among raft nodes before linearized reading' (duration: 268.391661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:26.985801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:33:26.658506Z","time spent":"327.085774ms","remote":"127.0.0.1:45728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-19T13:33:26.985945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.912619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-19T13:33:26.986282Z","caller":"traceutil/trace.go:171","msg":"trace[1529288687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1350; }","duration":"322.293148ms","start":"2026-04-19T13:33:26.663974Z","end":"2026-04-19T13:33:26.986267Z","steps":["trace[1529288687] 'agreement among raft nodes before linearized reading' (duration: 321.15464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T13:33:26.986435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T13:33:26.66395Z","time spent":"322.457652ms","remote":"127.0.0.1:45728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T13:33:27.222179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.616497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T13:33:27.222481Z","caller":"traceutil/trace.go:171","msg":"trace[472285790] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"231.867734ms","start":"2026-04-19T13:33:26.990596Z","end":"2026-04-19T13:33:27.222464Z","steps":["trace[472285790] 'process raft request' (duration: 231.797542ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:27.222592Z","caller":"traceutil/trace.go:171","msg":"trace[685409453] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"232.14189ms","start":"2026-04-19T13:33:26.990421Z","end":"2026-04-19T13:33:27.222562Z","steps":["trace[685409453] 'process raft request' (duration: 129.056432ms)","trace[685409453] 'compare' (duration: 102.398852ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T13:33:27.222615Z","caller":"traceutil/trace.go:171","msg":"trace[1588006943] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1404; }","duration":"115.013374ms","start":"2026-04-19T13:33:27.107578Z","end":"2026-04-19T13:33:27.222591Z","steps":["trace[1588006943] 'read index received' (duration: 11.827354ms)","trace[1588006943] 'applied index is now lower than readState.Index' (duration: 103.1825ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T13:33:27.222795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.206659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-19T13:33:27.222843Z","caller":"traceutil/trace.go:171","msg":"trace[1168250709] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1355; }","duration":"115.304092ms","start":"2026-04-19T13:33:27.107527Z","end":"2026-04-19T13:33:27.222831Z","steps":["trace[1168250709] 'agreement among raft nodes before linearized reading' (duration: 115.135638ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:27.222857Z","caller":"traceutil/trace.go:171","msg":"trace[1058685935] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"232.175702ms","start":"2026-04-19T13:33:26.99061Z","end":"2026-04-19T13:33:27.222785Z","steps":["trace[1058685935] 'process raft request' (duration: 231.816663ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T13:33:27.223125Z","caller":"traceutil/trace.go:171","msg":"trace[415862733] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"232.513099ms","start":"2026-04-19T13:33:26.990589Z","end":"2026-04-19T13:33:27.223102Z","steps":["trace[415862733] 'process raft request' (duration: 231.70127ms)"],"step_count":1}