{"level":"warn","ts":"2026-10-02T15:16:09.922017Z","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-02T15:16:09.922199Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.104: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.104:2380","--initial-cluster=instance=https://162.253.55.104:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.104:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.104: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-02T15:16:09.922315Z","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-02T15:16:09.924368Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.104:2380"]} {"level":"info","ts":"2026-10-02T15:16:09.924618Z","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-02T15:16:09.925343Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"]} {"level":"info","ts":"2026-10-02T15:16:09.925483Z","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.104:2380"],"listen-peer-urls":["https://162.253.55.104:2380"],"advertise-client-urls":["https://162.253.55.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.104: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-02T15:16:09.930179Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.407304ms"} {"level":"info","ts":"2026-10-02T15:16:09.937563Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8572cc3a5351216d","cluster-id":"c1a156b8f69e6a79"} {"level":"info","ts":"2026-10-02T15:16:09.937694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=()"} {"level":"info","ts":"2026-10-02T15:16:09.937731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became follower at term 0"} {"level":"info","ts":"2026-10-02T15:16:09.937763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8572cc3a5351216d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-02T15:16:09.937788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became follower at term 1"} {"level":"info","ts":"2026-10-02T15:16:09.937846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=(9615972705267425645)"} {"level":"warn","ts":"2026-10-02T15:16:09.943909Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-02T15:16:09.94545Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-02T15:16:09.94668Z","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-02T15:16:09.94905Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8572cc3a5351216d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-02T15:16:09.949183Z","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-02T15:16:09.949427Z","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-02T15:16:09.949435Z","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-02T15:16:09.94954Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8572cc3a5351216d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-02T15:16:09.950756Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d switched to configuration voters=(9615972705267425645)"} {"level":"info","ts":"2026-10-02T15:16:09.950936Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c1a156b8f69e6a79","local-member-id":"8572cc3a5351216d","added-peer-id":"8572cc3a5351216d","added-peer-peer-urls":["https://162.253.55.104:2380"]} {"level":"info","ts":"2026-10-02T15:16:09.953135Z","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-02T15:16:09.953247Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.104:2380"} {"level":"info","ts":"2026-10-02T15:16:09.953295Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.104:2380"} {"level":"info","ts":"2026-10-02T15:16:09.953404Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8572cc3a5351216d","initial-advertise-peer-urls":["https://162.253.55.104:2380"],"listen-peer-urls":["https://162.253.55.104:2380"],"advertise-client-urls":["https://162.253.55.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-02T15:16:09.953468Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-02T15:16:10.738637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d is starting a new election at term 1"} {"level":"info","ts":"2026-10-02T15:16:10.7387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became pre-candidate at term 1"} {"level":"info","ts":"2026-10-02T15:16:10.738734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d received MsgPreVoteResp from 8572cc3a5351216d at term 1"} {"level":"info","ts":"2026-10-02T15:16:10.738753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became candidate at term 2"} {"level":"info","ts":"2026-10-02T15:16:10.738769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d received MsgVoteResp from 8572cc3a5351216d at term 2"} {"level":"info","ts":"2026-10-02T15:16:10.738788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8572cc3a5351216d became leader at term 2"} {"level":"info","ts":"2026-10-02T15:16:10.738805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8572cc3a5351216d elected leader 8572cc3a5351216d at term 2"} {"level":"info","ts":"2026-10-02T15:16:10.740112Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8572cc3a5351216d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.104:2379]}","request-path":"/0/members/8572cc3a5351216d/attributes","cluster-id":"c1a156b8f69e6a79","publish-timeout":"7s"} {"level":"info","ts":"2026-10-02T15:16:10.740299Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T15:16:10.74043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T15:16:10.740498Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:16:10.742196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c1a156b8f69e6a79","local-member-id":"8572cc3a5351216d","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:16:10.742298Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:16:10.742327Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T15:16:10.743232Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.104:2379"} {"level":"info","ts":"2026-10-02T15:16:10.744068Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-02T15:16:10.744125Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-02T15:16:10.745372Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-02T15:16:13.415415Z","caller":"traceutil/trace.go:171","msg":"trace[56647896] linearizableReadLoop","detail":"{readStateIndex:74; appliedIndex:73; }","duration":"200.247027ms","start":"2026-10-02T15:16:13.215148Z","end":"2026-10-02T15:16:13.415395Z","steps":["trace[56647896] 'read index received' (duration: 200.050892ms)","trace[56647896] 'applied index is now lower than readState.Index' (duration: 195.155µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:16:13.415503Z","caller":"traceutil/trace.go:171","msg":"trace[1220332248] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"201.073728ms","start":"2026-10-02T15:16:13.214377Z","end":"2026-10-02T15:16:13.415451Z","steps":["trace[1220332248] 'process raft request' (duration: 200.904734ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:13.415623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.440052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T15:16:13.415683Z","caller":"traceutil/trace.go:171","msg":"trace[1797298502] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"200.546665ms","start":"2026-10-02T15:16:13.215126Z","end":"2026-10-02T15:16:13.415672Z","steps":["trace[1797298502] 'agreement among raft nodes before linearized reading' (duration: 200.402781ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:13.415845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.586027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T15:16:13.415963Z","caller":"traceutil/trace.go:171","msg":"trace[1059760270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:71; }","duration":"101.738921ms","start":"2026-10-02T15:16:13.314196Z","end":"2026-10-02T15:16:13.415935Z","steps":["trace[1059760270] 'agreement among raft nodes before linearized reading' (duration: 101.462374ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:13.674742Z","caller":"traceutil/trace.go:171","msg":"trace[399771462] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"249.709441ms","start":"2026-10-02T15:16:13.425001Z","end":"2026-10-02T15:16:13.67471Z","steps":["trace[399771462] 'read index received' (duration: 187.795164ms)","trace[399771462] 'applied index is now lower than readState.Index' (duration: 61.913137ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:16:13.674939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.915616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-02T15:16:13.674989Z","caller":"traceutil/trace.go:171","msg":"trace[2115327707] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:72; }","duration":"249.998039ms","start":"2026-10-02T15:16:13.424975Z","end":"2026-10-02T15:16:13.674973Z","steps":["trace[2115327707] 'agreement among raft nodes before linearized reading' (duration: 249.849095ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:13.674965Z","caller":"traceutil/trace.go:171","msg":"trace[1692765463] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"250.039879ms","start":"2026-10-02T15:16:13.424878Z","end":"2026-10-02T15:16:13.674918Z","steps":["trace[1692765463] 'process raft request' (duration: 187.803634ms)","trace[1692765463] 'compare' (duration: 61.892156ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:16:13.930804Z","caller":"traceutil/trace.go:171","msg":"trace[1185974738] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"244.411312ms","start":"2026-10-02T15:16:13.686333Z","end":"2026-10-02T15:16:13.930744Z","steps":["trace[1185974738] 'process raft request' (duration: 244.097204ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:14.113725Z","caller":"traceutil/trace.go:171","msg":"trace[259561153] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"177.089166ms","start":"2026-10-02T15:16:13.936609Z","end":"2026-10-02T15:16:14.113698Z","steps":["trace[259561153] 'process raft request' (duration: 114.83592ms)","trace[259561153] 'compare' (duration: 62.043471ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:16:48.440844Z","caller":"traceutil/trace.go:171","msg":"trace[675969674] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"230.367388ms","start":"2026-10-02T15:16:48.21045Z","end":"2026-10-02T15:16:48.440818Z","steps":["trace[675969674] 'process raft request' (duration: 230.251555ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.449933Z","caller":"traceutil/trace.go:171","msg":"trace[788966070] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"238.838709ms","start":"2026-10-02T15:16:48.211068Z","end":"2026-10-02T15:16:48.449907Z","steps":["trace[788966070] 'process raft request' (duration: 238.568032ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450032Z","caller":"traceutil/trace.go:171","msg":"trace[1261954828] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"230.960145ms","start":"2026-10-02T15:16:48.219019Z","end":"2026-10-02T15:16:48.449979Z","steps":["trace[1261954828] 'process raft request' (duration: 230.740919ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450154Z","caller":"traceutil/trace.go:171","msg":"trace[1682951035] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"231.21694ms","start":"2026-10-02T15:16:48.218919Z","end":"2026-10-02T15:16:48.450136Z","steps":["trace[1682951035] 'process raft request' (duration: 230.802869ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450133Z","caller":"traceutil/trace.go:171","msg":"trace[1455235803] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"230.732339ms","start":"2026-10-02T15:16:48.219317Z","end":"2026-10-02T15:16:48.45005Z","steps":["trace[1455235803] 'process raft request' (duration: 230.498533ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450359Z","caller":"traceutil/trace.go:171","msg":"trace[1530982666] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"214.112968ms","start":"2026-10-02T15:16:48.236233Z","end":"2026-10-02T15:16:48.450346Z","steps":["trace[1530982666] 'process raft request' (duration: 213.767819ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450415Z","caller":"traceutil/trace.go:171","msg":"trace[1865763850] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"210.801011ms","start":"2026-10-02T15:16:48.239599Z","end":"2026-10-02T15:16:48.4504Z","steps":["trace[1865763850] 'process raft request' (duration: 210.484323ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450416Z","caller":"traceutil/trace.go:171","msg":"trace[796981029] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"217.536696ms","start":"2026-10-02T15:16:48.232823Z","end":"2026-10-02T15:16:48.45036Z","steps":["trace[796981029] 'process raft request' (duration: 217.118235ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450433Z","caller":"traceutil/trace.go:171","msg":"trace[992194082] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"221.865868ms","start":"2026-10-02T15:16:48.228537Z","end":"2026-10-02T15:16:48.450403Z","steps":["trace[992194082] 'process raft request' (duration: 221.364525ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450489Z","caller":"traceutil/trace.go:171","msg":"trace[917572791] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"169.753866ms","start":"2026-10-02T15:16:48.280724Z","end":"2026-10-02T15:16:48.450478Z","steps":["trace[917572791] 'process raft request' (duration: 169.546061ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:48.450607Z","caller":"traceutil/trace.go:171","msg":"trace[358672135] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"166.05823ms","start":"2026-10-02T15:16:48.284535Z","end":"2026-10-02T15:16:48.450593Z","steps":["trace[358672135] 'process raft request' (duration: 165.852635ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:55.153425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.626045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:16:55.153556Z","caller":"traceutil/trace.go:171","msg":"trace[258773447] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"231.543559ms","start":"2026-10-02T15:16:54.921991Z","end":"2026-10-02T15:16:55.153535Z","steps":["trace[258773447] 'read index received' (duration: 44.028792ms)","trace[258773447] 'applied index is now lower than readState.Index' (duration: 187.512967ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:16:55.153641Z","caller":"traceutil/trace.go:171","msg":"trace[1214917407] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"263.804487ms","start":"2026-10-02T15:16:54.889823Z","end":"2026-10-02T15:16:55.153628Z","steps":["trace[1214917407] 'process raft request' (duration: 76.202537ms)","trace[1214917407] 'compare' (duration: 186.487051ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:16:55.153736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.711343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.104\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-02T15:16:55.153819Z","caller":"traceutil/trace.go:171","msg":"trace[504267828] range","detail":"{range_begin:/registry/masterleases/162.253.55.104; range_end:; response_count:1; response_revision:627; }","duration":"231.828197ms","start":"2026-10-02T15:16:54.921965Z","end":"2026-10-02T15:16:55.153793Z","steps":["trace[504267828] 'agreement among raft nodes before linearized reading' (duration: 231.669833ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:16:55.214275Z","caller":"traceutil/trace.go:171","msg":"trace[62166753] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"277.219605ms","start":"2026-10-02T15:16:54.937016Z","end":"2026-10-02T15:16:55.214236Z","steps":["trace[62166753] 'process raft request' (duration: 276.955758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:55.214333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.396565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-02T15:16:55.214405Z","caller":"traceutil/trace.go:171","msg":"trace[2060689563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"130.530398ms","start":"2026-10-02T15:16:55.083854Z","end":"2026-10-02T15:16:55.214385Z","steps":["trace[2060689563] 'agreement among raft nodes before linearized reading' (duration: 130.272371ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:56.014431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.347955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T15:16:56.014541Z","caller":"traceutil/trace.go:171","msg":"trace[717668777] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"694.786989ms","start":"2026-10-02T15:16:55.319737Z","end":"2026-10-02T15:16:56.014524Z","steps":["trace[717668777] 'read index received' (duration: 61.612µs)","trace[717668777] 'applied index is now lower than readState.Index' (duration: 694.723497ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:16:56.014592Z","caller":"traceutil/trace.go:171","msg":"trace[1888670580] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"780.322919ms","start":"2026-10-02T15:16:55.234234Z","end":"2026-10-02T15:16:56.014557Z","steps":["trace[1888670580] 'process raft request' (duration: 20.752848ms)","trace[1888670580] 'compare' (duration: 758.991305ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:16:56.014728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.996844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-02T15:16:56.014765Z","caller":"traceutil/trace.go:171","msg":"trace[734970058] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"695.092567ms","start":"2026-10-02T15:16:55.319663Z","end":"2026-10-02T15:16:56.014756Z","steps":["trace[734970058] 'agreement among raft nodes before linearized reading' (duration: 694.929993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:56.014795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:16:55.319641Z","time spent":"695.146248ms","remote":"127.0.0.1:55794","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-10-02T15:16:56.01477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:16:55.234186Z","time spent":"780.480903ms","remote":"127.0.0.1:36720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T15:16:56.041384Z","caller":"traceutil/trace.go:171","msg":"trace[1569832008] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"417.377306ms","start":"2026-10-02T15:16:55.62398Z","end":"2026-10-02T15:16:56.041357Z","steps":["trace[1569832008] 'process raft request' (duration: 416.576225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:56.041493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.826766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:16:56.041542Z","caller":"traceutil/trace.go:171","msg":"trace[95895028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"484.934538ms","start":"2026-10-02T15:16:55.556594Z","end":"2026-10-02T15:16:56.041528Z","steps":["trace[95895028] 'agreement among raft nodes before linearized reading' (duration: 484.849136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:56.041561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.251466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-02T15:16:56.041569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:16:55.623935Z","time spent":"417.530079ms","remote":"127.0.0.1:36788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036153,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T15:16:56.041617Z","caller":"traceutil/trace.go:171","msg":"trace[1906015774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"463.340798ms","start":"2026-10-02T15:16:55.578261Z","end":"2026-10-02T15:16:56.041602Z","steps":["trace[1906015774] 'agreement among raft nodes before linearized reading' (duration: 463.131983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:16:56.041573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:16:55.556565Z","time spent":"485.000519ms","remote":"127.0.0.1:36670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-02T15:16:56.041657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T15:16:55.57824Z","time spent":"463.405219ms","remote":"127.0.0.1:55794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-02T15:17:11.718813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.281676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:17:11.718898Z","caller":"traceutil/trace.go:171","msg":"trace[1154606525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"163.41356ms","start":"2026-10-02T15:17:11.555466Z","end":"2026-10-02T15:17:11.71888Z","steps":["trace[1154606525] 'range keys from in-memory index tree' (duration: 163.214785ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:17:51.216891Z","caller":"traceutil/trace.go:171","msg":"trace[893479461] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"201.282213ms","start":"2026-10-02T15:17:51.015588Z","end":"2026-10-02T15:17:51.216871Z","steps":["trace[893479461] 'read index received' (duration: 201.092448ms)","trace[893479461] 'applied index is now lower than readState.Index' (duration: 188.925µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:17:51.216965Z","caller":"traceutil/trace.go:171","msg":"trace[469037353] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"221.523893ms","start":"2026-10-02T15:17:50.995421Z","end":"2026-10-02T15:17:51.216945Z","steps":["trace[469037353] 'process raft request' (duration: 221.314697ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:17:51.217027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.407636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:17:51.217071Z","caller":"traceutil/trace.go:171","msg":"trace[1965374315] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1087; }","duration":"201.500049ms","start":"2026-10-02T15:17:51.015555Z","end":"2026-10-02T15:17:51.217055Z","steps":["trace[1965374315] 'agreement among raft nodes before linearized reading' (duration: 201.409396ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:05.409074Z","caller":"traceutil/trace.go:171","msg":"trace[1933109617] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"130.984578ms","start":"2026-10-02T15:18:05.278053Z","end":"2026-10-02T15:18:05.409038Z","steps":["trace[1933109617] 'process raft request' (duration: 130.809293ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:06.597197Z","caller":"traceutil/trace.go:171","msg":"trace[1297730266] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"153.584046ms","start":"2026-10-02T15:18:06.443592Z","end":"2026-10-02T15:18:06.597176Z","steps":["trace[1297730266] 'process raft request' (duration: 153.457902ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:06.597473Z","caller":"traceutil/trace.go:171","msg":"trace[1996666663] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1183; }","duration":"148.086503ms","start":"2026-10-02T15:18:06.449375Z","end":"2026-10-02T15:18:06.597461Z","steps":["trace[1996666663] 'read index received' (duration: 148.081643ms)","trace[1996666663] 'applied index is now lower than readState.Index' (duration: 3.75µs)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:18:06.597864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.486943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-02T15:18:06.597906Z","caller":"traceutil/trace.go:171","msg":"trace[1600137707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1138; }","duration":"148.576746ms","start":"2026-10-02T15:18:06.449319Z","end":"2026-10-02T15:18:06.597896Z","steps":["trace[1600137707] 'agreement among raft nodes before linearized reading' (duration: 148.461282ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:06.822324Z","caller":"traceutil/trace.go:171","msg":"trace[2074505684] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"195.119186ms","start":"2026-10-02T15:18:06.627181Z","end":"2026-10-02T15:18:06.822301Z","steps":["trace[2074505684] 'read index received' (duration: 168.641868ms)","trace[2074505684] 'applied index is now lower than readState.Index' (duration: 26.476018ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:18:06.822457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.260599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:18:06.822486Z","caller":"traceutil/trace.go:171","msg":"trace[1529497467] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1139; }","duration":"195.347173ms","start":"2026-10-02T15:18:06.62713Z","end":"2026-10-02T15:18:06.822477Z","steps":["trace[1529497467] 'agreement among raft nodes before linearized reading' (duration: 195.25259ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:06.822759Z","caller":"traceutil/trace.go:171","msg":"trace[554495220] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"220.552628ms","start":"2026-10-02T15:18:06.602194Z","end":"2026-10-02T15:18:06.822747Z","steps":["trace[554495220] 'process raft request' (duration: 193.686199ms)","trace[554495220] 'compare' (duration: 26.219993ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:18:07.322864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.506396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-02T15:18:07.322945Z","caller":"traceutil/trace.go:171","msg":"trace[1458058571] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1140; }","duration":"110.629049ms","start":"2026-10-02T15:18:07.212296Z","end":"2026-10-02T15:18:07.322925Z","steps":["trace[1458058571] 'count revisions from in-memory index tree' (duration: 110.374882ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:07.733034Z","caller":"traceutil/trace.go:171","msg":"trace[2002772420] linearizableReadLoop","detail":"{readStateIndex:1187; appliedIndex:1186; }","duration":"177.221462ms","start":"2026-10-02T15:18:07.555787Z","end":"2026-10-02T15:18:07.733009Z","steps":["trace[2002772420] 'read index received' (duration: 135.24093ms)","trace[2002772420] 'applied index is now lower than readState.Index' (duration: 41.979541ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T15:18:07.733131Z","caller":"traceutil/trace.go:171","msg":"trace[1713934182] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"227.742306ms","start":"2026-10-02T15:18:07.505346Z","end":"2026-10-02T15:18:07.733088Z","steps":["trace[1713934182] 'process raft request' (duration: 185.675451ms)","trace[1713934182] 'compare' (duration: 41.809218ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:18:07.733232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.435637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T15:18:07.73329Z","caller":"traceutil/trace.go:171","msg":"trace[464324209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1142; }","duration":"177.53734ms","start":"2026-10-02T15:18:07.555737Z","end":"2026-10-02T15:18:07.733275Z","steps":["trace[464324209] 'agreement among raft nodes before linearized reading' (duration: 177.433147ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T15:18:07.733373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.681701ms","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-02T15:18:07.733418Z","caller":"traceutil/trace.go:171","msg":"trace[1139662573] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1142; }","duration":"117.786294ms","start":"2026-10-02T15:18:07.61562Z","end":"2026-10-02T15:18:07.733406Z","steps":["trace[1139662573] 'agreement among raft nodes before linearized reading' (duration: 117.613129ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:08.334687Z","caller":"traceutil/trace.go:171","msg":"trace[1472742039] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"142.448916ms","start":"2026-10-02T15:18:08.192209Z","end":"2026-10-02T15:18:08.334658Z","steps":["trace[1472742039] 'process raft request' (duration: 142.343203ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:18:20.5755Z","caller":"traceutil/trace.go:171","msg":"trace[404223885] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"187.21557ms","start":"2026-10-02T15:18:20.388263Z","end":"2026-10-02T15:18:20.575478Z","steps":["trace[404223885] 'read index received' (duration: 87.612829ms)","trace[404223885] 'applied index is now lower than readState.Index' (duration: 99.601811ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T15:18:20.575686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.407205ms","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-02T15:18:20.575723Z","caller":"traceutil/trace.go:171","msg":"trace[238706132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1245; }","duration":"187.492728ms","start":"2026-10-02T15:18:20.38822Z","end":"2026-10-02T15:18:20.575713Z","steps":["trace[238706132] 'agreement among raft nodes before linearized reading' (duration: 187.350474ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T15:23:04.952579Z","caller":"traceutil/trace.go:171","msg":"trace[478626667] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"115.913146ms","start":"2026-10-02T15:23:04.836642Z","end":"2026-10-02T15:23:04.952555Z","steps":["trace[478626667] 'process raft request' (duration: 115.748362ms)"],"step_count":1}