{"level":"warn","ts":"2026-09-12T03:59:11.497834Z","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-12T03:59:11.497923Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.107: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.107:2380","--initial-cluster=instance=https://162.253.55.107:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.107:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.107: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-12T03:59:11.498002Z","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-12T03:59:11.498015Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.107:2380"]} {"level":"info","ts":"2026-09-12T03:59:11.498032Z","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-12T03:59:11.498663Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.107:2379"]} {"level":"info","ts":"2026-09-12T03:59:11.498735Z","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.107:2380"],"listen-peer-urls":["https://162.253.55.107:2380"],"advertise-client-urls":["https://162.253.55.107:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.107:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.107: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-12T03:59:11.503299Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.351122ms"} {"level":"info","ts":"2026-09-12T03:59:11.516228Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9139094afdb348df","cluster-id":"a56c8121e8858232"} {"level":"info","ts":"2026-09-12T03:59:11.516331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T03:59:11.516357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became follower at term 0"} {"level":"info","ts":"2026-09-12T03:59:11.516368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9139094afdb348df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T03:59:11.516376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became follower at term 1"} {"level":"info","ts":"2026-09-12T03:59:11.516411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df switched to configuration voters=(10464405426860673247)"} {"level":"warn","ts":"2026-09-12T03:59:11.522517Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T03:59:11.523949Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T03:59:11.525356Z","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-12T03:59:11.527503Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9139094afdb348df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T03:59:11.527576Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9139094afdb348df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T03:59:11.527967Z","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-12T03:59:11.528146Z","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-12T03:59:11.52818Z","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-12T03:59:11.530568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df switched to configuration voters=(10464405426860673247)"} {"level":"info","ts":"2026-09-12T03:59:11.530757Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a56c8121e8858232","local-member-id":"9139094afdb348df","added-peer-id":"9139094afdb348df","added-peer-peer-urls":["https://162.253.55.107:2380"]} {"level":"info","ts":"2026-09-12T03:59:11.531386Z","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-12T03:59:11.531499Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.107:2380"} {"level":"info","ts":"2026-09-12T03:59:11.531533Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.107:2380"} {"level":"info","ts":"2026-09-12T03:59:11.531604Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9139094afdb348df","initial-advertise-peer-urls":["https://162.253.55.107:2380"],"listen-peer-urls":["https://162.253.55.107:2380"],"advertise-client-urls":["https://162.253.55.107:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.107:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T03:59:11.53164Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T03:59:12.017397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T03:59:12.01746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T03:59:12.017523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df received MsgPreVoteResp from 9139094afdb348df at term 1"} {"level":"info","ts":"2026-09-12T03:59:12.017579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became candidate at term 2"} {"level":"info","ts":"2026-09-12T03:59:12.017598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df received MsgVoteResp from 9139094afdb348df at term 2"} {"level":"info","ts":"2026-09-12T03:59:12.017613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became leader at term 2"} {"level":"info","ts":"2026-09-12T03:59:12.017627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9139094afdb348df elected leader 9139094afdb348df at term 2"} {"level":"info","ts":"2026-09-12T03:59:12.01855Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:59:12.019682Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T03:59:12.019691Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9139094afdb348df","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.107:2379]}","request-path":"/0/members/9139094afdb348df/attributes","cluster-id":"a56c8121e8858232","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T03:59:12.019776Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T03:59:12.020159Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a56c8121e8858232","local-member-id":"9139094afdb348df","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:59:12.020205Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T03:59:12.020281Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:59:12.020302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T03:59:12.020321Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T03:59:12.02205Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.107:2379"} {"level":"info","ts":"2026-09-12T03:59:12.023656Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-12T03:59:15.552644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.441643ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T03:59:15.55282Z","caller":"traceutil/trace.go:171","msg":"trace[986671193] transaction","detail":"{read_only:false; response_revision:159; number_of_response:1; }","duration":"404.570179ms","start":"2026-09-12T03:59:15.148227Z","end":"2026-09-12T03:59:15.552797Z","steps":["trace[986671193] 'process raft request' (duration: 165.328156ms)","trace[986671193] 'compare' (duration: 238.232889ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:59:15.55292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:59:15.148214Z","time spent":"404.658486ms","remote":"127.0.0.1:55728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T03:59:15.863295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.747139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T03:59:15.863413Z","caller":"traceutil/trace.go:171","msg":"trace[1968853085] linearizableReadLoop","detail":"{readStateIndex:164; appliedIndex:163; }","duration":"248.083756ms","start":"2026-09-12T03:59:15.615313Z","end":"2026-09-12T03:59:15.863397Z","steps":["trace[1968853085] 'read index received' (duration: 78.884069ms)","trace[1968853085] 'applied index is now lower than readState.Index' (duration: 169.198248ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T03:59:15.863466Z","caller":"traceutil/trace.go:171","msg":"trace[2081908010] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"305.304209ms","start":"2026-09-12T03:59:15.558122Z","end":"2026-09-12T03:59:15.863426Z","steps":["trace[2081908010] 'process raft request' (duration: 136.1419ms)","trace[2081908010] 'compare' (duration: 168.591794ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:59:15.863589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:59:15.558099Z","time spent":"305.439125ms","remote":"127.0.0.1:55728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-12T03:59:15.863906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.382569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T03:59:15.863967Z","caller":"traceutil/trace.go:171","msg":"trace[1892262694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:160; }","duration":"248.682221ms","start":"2026-09-12T03:59:15.615272Z","end":"2026-09-12T03:59:15.863954Z","steps":["trace[1892262694] 'agreement among raft nodes before linearized reading' (duration: 248.166753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:59:17.933068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.174537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T03:59:17.933264Z","caller":"traceutil/trace.go:171","msg":"trace[1332125395] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"287.020548ms","start":"2026-09-12T03:59:17.646164Z","end":"2026-09-12T03:59:17.933184Z","steps":["trace[1332125395] 'read index received' (duration: 6.567178ms)","trace[1332125395] 'applied index is now lower than readState.Index' (duration: 280.45025ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T03:59:17.933451Z","caller":"traceutil/trace.go:171","msg":"trace[56432395] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"305.488964ms","start":"2026-09-12T03:59:17.627894Z","end":"2026-09-12T03:59:17.933383Z","steps":["trace[56432395] 'process raft request' (duration: 24.921946ms)","trace[56432395] 'compare' (duration: 279.560023ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:59:17.93351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.346211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-12T03:59:17.93361Z","caller":"traceutil/trace.go:171","msg":"trace[1484098782] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"287.504037ms","start":"2026-09-12T03:59:17.646089Z","end":"2026-09-12T03:59:17.933593Z","steps":["trace[1484098782] 'agreement among raft nodes before linearized reading' (duration: 287.223994ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:59:17.933803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:59:17.627875Z","time spent":"305.65129ms","remote":"127.0.0.1:55706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":356,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T03:59:17.935738Z","caller":"traceutil/trace.go:171","msg":"trace[97942650] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"266.290189ms","start":"2026-09-12T03:59:17.669414Z","end":"2026-09-12T03:59:17.935704Z","steps":["trace[97942650] 'process raft request' (duration: 266.210711ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:50.683553Z","caller":"traceutil/trace.go:171","msg":"trace[1801397539] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"112.40822ms","start":"2026-09-12T03:59:50.571107Z","end":"2026-09-12T03:59:50.683515Z","steps":["trace[1801397539] 'process raft request' (duration: 65.145415ms)","trace[1801397539] 'compare' (duration: 47.090007ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T03:59:52.636218Z","caller":"traceutil/trace.go:171","msg":"trace[1975300757] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"151.779838ms","start":"2026-09-12T03:59:52.484411Z","end":"2026-09-12T03:59:52.636191Z","steps":["trace[1975300757] 'process raft request' (duration: 116.236004ms)","trace[1975300757] 'compare' (duration: 35.390875ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T03:59:52.636451Z","caller":"traceutil/trace.go:171","msg":"trace[1453009014] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"151.397932ms","start":"2026-09-12T03:59:52.485025Z","end":"2026-09-12T03:59:52.636423Z","steps":["trace[1453009014] 'process raft request' (duration: 151.315694ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.63656Z","caller":"traceutil/trace.go:171","msg":"trace[283501153] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"144.13636ms","start":"2026-09-12T03:59:52.4924Z","end":"2026-09-12T03:59:52.636536Z","steps":["trace[283501153] 'process raft request' (duration: 143.996592ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.636525Z","caller":"traceutil/trace.go:171","msg":"trace[397486992] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"151.514661ms","start":"2026-09-12T03:59:52.48495Z","end":"2026-09-12T03:59:52.636465Z","steps":["trace[397486992] 'process raft request' (duration: 151.287284ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.636611Z","caller":"traceutil/trace.go:171","msg":"trace[1507528687] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"144.052731ms","start":"2026-09-12T03:59:52.492524Z","end":"2026-09-12T03:59:52.636577Z","steps":["trace[1507528687] 'process raft request' (duration: 143.978762ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.636623Z","caller":"traceutil/trace.go:171","msg":"trace[22589278] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"147.948729ms","start":"2026-09-12T03:59:52.488641Z","end":"2026-09-12T03:59:52.63659Z","steps":["trace[22589278] 'process raft request' (duration: 147.735202ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.636781Z","caller":"traceutil/trace.go:171","msg":"trace[892203753] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"137.258992ms","start":"2026-09-12T03:59:52.499515Z","end":"2026-09-12T03:59:52.636774Z","steps":["trace[892203753] 'process raft request' (duration: 137.002536ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.637045Z","caller":"traceutil/trace.go:171","msg":"trace[1720659678] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"137.346962ms","start":"2026-09-12T03:59:52.499687Z","end":"2026-09-12T03:59:52.637034Z","steps":["trace[1720659678] 'process raft request' (duration: 137.252872ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.637571Z","caller":"traceutil/trace.go:171","msg":"trace[1795236713] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"128.863954ms","start":"2026-09-12T03:59:52.508688Z","end":"2026-09-12T03:59:52.637552Z","steps":["trace[1795236713] 'process raft request' (duration: 128.366671ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.637665Z","caller":"traceutil/trace.go:171","msg":"trace[2010599016] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"135.647834ms","start":"2026-09-12T03:59:52.502001Z","end":"2026-09-12T03:59:52.637649Z","steps":["trace[2010599016] 'process raft request' (duration: 134.993542ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.637865Z","caller":"traceutil/trace.go:171","msg":"trace[1517009234] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"135.285588ms","start":"2026-09-12T03:59:52.502568Z","end":"2026-09-12T03:59:52.637853Z","steps":["trace[1517009234] 'process raft request' (duration: 134.45334ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.638669Z","caller":"traceutil/trace.go:171","msg":"trace[732216296] transaction","detail":"{read_only:false; number_of_response:1; response_revision:547; }","duration":"139.074558ms","start":"2026-09-12T03:59:52.499582Z","end":"2026-09-12T03:59:52.638656Z","steps":["trace[732216296] 'process raft request' (duration: 136.953117ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.63979Z","caller":"traceutil/trace.go:171","msg":"trace[259785447] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"119.221873ms","start":"2026-09-12T03:59:52.520467Z","end":"2026-09-12T03:59:52.639689Z","steps":["trace[259785447] 'process raft request' (duration: 119.072105ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:52.640025Z","caller":"traceutil/trace.go:171","msg":"trace[1999123967] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"130.184518ms","start":"2026-09-12T03:59:52.509814Z","end":"2026-09-12T03:59:52.639998Z","steps":["trace[1999123967] 'process raft request' (duration: 127.678591ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:54.081403Z","caller":"traceutil/trace.go:171","msg":"trace[495577884] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"218.92438ms","start":"2026-09-12T03:59:53.862448Z","end":"2026-09-12T03:59:54.081372Z","steps":["trace[495577884] 'read index received' (duration: 218.472965ms)","trace[495577884] 'applied index is now lower than readState.Index' (duration: 450.145µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:59:54.081677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.195786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"} {"level":"info","ts":"2026-09-12T03:59:54.081724Z","caller":"traceutil/trace.go:171","msg":"trace[1530249716] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:606; }","duration":"219.306764ms","start":"2026-09-12T03:59:53.862401Z","end":"2026-09-12T03:59:54.081708Z","steps":["trace[1530249716] 'agreement among raft nodes before linearized reading' (duration: 219.090907ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:54.082541Z","caller":"traceutil/trace.go:171","msg":"trace[1523013907] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"225.120338ms","start":"2026-09-12T03:59:53.857406Z","end":"2026-09-12T03:59:54.082527Z","steps":["trace[1523013907] 'process raft request' (duration: 223.37685ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:54.225283Z","caller":"traceutil/trace.go:171","msg":"trace[1401912025] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"333.198171ms","start":"2026-09-12T03:59:53.89206Z","end":"2026-09-12T03:59:54.225259Z","steps":["trace[1401912025] 'process raft request' (duration: 327.620323ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:54.225627Z","caller":"traceutil/trace.go:171","msg":"trace[588133096] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"126.898022ms","start":"2026-09-12T03:59:54.098664Z","end":"2026-09-12T03:59:54.225562Z","steps":["trace[588133096] 'read index received' (duration: 120.942389ms)","trace[588133096] 'applied index is now lower than readState.Index' (duration: 5.946823ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T03:59:54.225676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:59:53.891971Z","time spent":"333.373818ms","remote":"127.0.0.1:55436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T03:59:54.226037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.345237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-09-12T03:59:54.226249Z","caller":"traceutil/trace.go:171","msg":"trace[886178967] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:608; }","duration":"127.587753ms","start":"2026-09-12T03:59:54.098613Z","end":"2026-09-12T03:59:54.2262Z","steps":["trace[886178967] 'agreement among raft nodes before linearized reading' (duration: 127.054249ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:59.153274Z","caller":"traceutil/trace.go:171","msg":"trace[1845499570] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"109.000145ms","start":"2026-09-12T03:59:59.04424Z","end":"2026-09-12T03:59:59.15324Z","steps":["trace[1845499570] 'process raft request' (duration: 105.477996ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:59.662536Z","caller":"traceutil/trace.go:171","msg":"trace[171584192] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"113.934327ms","start":"2026-09-12T03:59:59.548541Z","end":"2026-09-12T03:59:59.662476Z","steps":["trace[171584192] 'read index received' (duration: 112.121738ms)","trace[171584192] 'applied index is now lower than readState.Index' (duration: 1.810739ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T03:59:59.663307Z","caller":"traceutil/trace.go:171","msg":"trace[736577844] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"378.874743ms","start":"2026-09-12T03:59:59.284369Z","end":"2026-09-12T03:59:59.663243Z","steps":["trace[736577844] 'process raft request' (duration: 376.763768ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T03:59:59.66343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.854866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4chd6\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-09-12T03:59:59.66354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T03:59:59.284337Z","time spent":"379.090339ms","remote":"127.0.0.1:55468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T03:59:59.663569Z","caller":"traceutil/trace.go:171","msg":"trace[809497253] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4chd6; range_end:; response_count:1; response_revision:642; }","duration":"115.089743ms","start":"2026-09-12T03:59:59.548458Z","end":"2026-09-12T03:59:59.663547Z","steps":["trace[809497253] 'agreement among raft nodes before linearized reading' (duration: 114.195453ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T03:59:59.795338Z","caller":"traceutil/trace.go:171","msg":"trace[1870551861] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"106.451504ms","start":"2026-09-12T03:59:59.688839Z","end":"2026-09-12T03:59:59.795291Z","steps":["trace[1870551861] 'process raft request' (duration: 105.98468ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:00:17.42Z","caller":"traceutil/trace.go:171","msg":"trace[983538193] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"171.14148ms","start":"2026-09-12T04:00:17.248831Z","end":"2026-09-12T04:00:17.419972Z","steps":["trace[983538193] 'process raft request' (duration: 170.974102ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:00:17.50169Z","caller":"traceutil/trace.go:171","msg":"trace[2000618277] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:839; }","duration":"225.593143ms","start":"2026-09-12T04:00:17.276064Z","end":"2026-09-12T04:00:17.501657Z","steps":["trace[2000618277] 'read index received' (duration: 143.732872ms)","trace[2000618277] 'applied index is now lower than readState.Index' (duration: 81.858931ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:00:17.501782Z","caller":"traceutil/trace.go:171","msg":"trace[1159741186] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"248.46446ms","start":"2026-09-12T04:00:17.253271Z","end":"2026-09-12T04:00:17.501736Z","steps":["trace[1159741186] 'process raft request' (duration: 213.429844ms)","trace[1159741186] 'compare' (duration: 34.821768ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:00:17.501851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.768062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-12T04:00:17.501992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.598437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-12T04:00:17.50206Z","caller":"traceutil/trace.go:171","msg":"trace[1717452939] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:813; }","duration":"158.698586ms","start":"2026-09-12T04:00:17.34335Z","end":"2026-09-12T04:00:17.502048Z","steps":["trace[1717452939] 'agreement among raft nodes before linearized reading' (duration: 158.488148ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:00:17.501926Z","caller":"traceutil/trace.go:171","msg":"trace[2054199392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"225.92213ms","start":"2026-09-12T04:00:17.275983Z","end":"2026-09-12T04:00:17.501905Z","steps":["trace[2054199392] 'agreement among raft nodes before linearized reading' (duration: 225.792141ms)"],"step_count":1}