{"level":"warn","ts":"2026-05-05T10:19:22.488598Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T10:19:22.488727Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.29: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.19.213.29:2380","--initial-cluster=instance=https://199.19.213.29:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.29:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.29: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-05-05T10:19:22.489102Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T10:19:22.489119Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.29:2380"]} {"level":"info","ts":"2026-05-05T10:19:22.489141Z","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-05-05T10:19:22.490128Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.29:2379"]} {"level":"info","ts":"2026-05-05T10:19:22.490218Z","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.19.213.29:2380"],"listen-peer-urls":["https://199.19.213.29:2380"],"advertise-client-urls":["https://199.19.213.29:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.29:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.29: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-05-05T10:19:22.49513Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.653226ms"} {"level":"info","ts":"2026-05-05T10:19:22.502327Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b1ecbac2f2214dbd","cluster-id":"94b127ce9c24156a"} {"level":"info","ts":"2026-05-05T10:19:22.502398Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T10:19:22.502415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became follower at term 0"} {"level":"info","ts":"2026-05-05T10:19:22.502427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b1ecbac2f2214dbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T10:19:22.502435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became follower at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.502502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd switched to configuration voters=(12820827585665650109)"} {"level":"warn","ts":"2026-05-05T10:19:22.507075Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T10:19:22.508324Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T10:19:22.509113Z","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-05-05T10:19:22.511407Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b1ecbac2f2214dbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T10:19:22.511673Z","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-05-05T10:19:22.511764Z","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-05-05T10:19:22.511777Z","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-05-05T10:19:22.51195Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b1ecbac2f2214dbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T10:19:22.512924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd switched to configuration voters=(12820827585665650109)"} {"level":"info","ts":"2026-05-05T10:19:22.513087Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"94b127ce9c24156a","local-member-id":"b1ecbac2f2214dbd","added-peer-id":"b1ecbac2f2214dbd","added-peer-peer-urls":["https://199.19.213.29:2380"]} {"level":"info","ts":"2026-05-05T10:19:22.516623Z","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-05-05T10:19:22.516747Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.29:2380"} {"level":"info","ts":"2026-05-05T10:19:22.516789Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.29:2380"} {"level":"info","ts":"2026-05-05T10:19:22.517125Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b1ecbac2f2214dbd","initial-advertise-peer-urls":["https://199.19.213.29:2380"],"listen-peer-urls":["https://199.19.213.29:2380"],"advertise-client-urls":["https://199.19.213.29:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.29:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T10:19:22.517179Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T10:19:22.703642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.703706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.703742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd received MsgPreVoteResp from b1ecbac2f2214dbd at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.703762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became candidate at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.703779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd received MsgVoteResp from b1ecbac2f2214dbd at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.703867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1ecbac2f2214dbd became leader at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.703886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b1ecbac2f2214dbd elected leader b1ecbac2f2214dbd at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.704772Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.70546Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:19:22.705459Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b1ecbac2f2214dbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.29:2379]}","request-path":"/0/members/b1ecbac2f2214dbd/attributes","cluster-id":"94b127ce9c24156a","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T10:19:22.705539Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:19:22.705992Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"94b127ce9c24156a","local-member-id":"b1ecbac2f2214dbd","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.706159Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.706159Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T10:19:22.706226Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T10:19:22.70622Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.707996Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T10:19:22.712977Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.29:2379"} {"level":"warn","ts":"2026-05-05T10:19:24.550276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.218391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-05T10:19:24.550472Z","caller":"traceutil/trace.go:171","msg":"trace[1155636172] linearizableReadLoop","detail":"{readStateIndex:64; appliedIndex:62; }","duration":"179.201135ms","start":"2026-05-05T10:19:24.371254Z","end":"2026-05-05T10:19:24.550456Z","steps":["trace[1155636172] 'read index received' (duration: 41.061027ms)","trace[1155636172] 'applied index is now lower than readState.Index' (duration: 138.139398ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:24.550637Z","caller":"traceutil/trace.go:171","msg":"trace[1228353322] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"272.60877ms","start":"2026-05-05T10:19:24.278011Z","end":"2026-05-05T10:19:24.55062Z","steps":["trace[1228353322] 'process raft request' (duration: 272.378033ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:24.550671Z","caller":"traceutil/trace.go:171","msg":"trace[1820094442] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"277.565074ms","start":"2026-05-05T10:19:24.273054Z","end":"2026-05-05T10:19:24.55062Z","steps":["trace[1820094442] 'process raft request' (duration: 139.336973ms)","trace[1820094442] 'compare' (duration: 137.121428ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:24.55072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.442033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T10:19:24.550784Z","caller":"traceutil/trace.go:171","msg":"trace[1649181559] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:60; }","duration":"179.550525ms","start":"2026-05-05T10:19:24.371215Z","end":"2026-05-05T10:19:24.550765Z","steps":["trace[1649181559] 'agreement among raft nodes before linearized reading' (duration: 179.37666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:27.271699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.290693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-05T10:19:27.271827Z","caller":"traceutil/trace.go:171","msg":"trace[2015821742] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:236; }","duration":"114.425166ms","start":"2026-05-05T10:19:27.157369Z","end":"2026-05-05T10:19:27.271795Z","steps":["trace[2015821742] 'range keys from in-memory index tree' (duration: 114.20053ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.379225Z","caller":"traceutil/trace.go:171","msg":"trace[1980473715] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"104.58094ms","start":"2026-05-05T10:19:27.274622Z","end":"2026-05-05T10:19:27.379203Z","steps":["trace[1980473715] 'process raft request' (duration: 104.323642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:27.710268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.620751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:19:27.710489Z","caller":"traceutil/trace.go:171","msg":"trace[1312927084] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"248.60134ms","start":"2026-05-05T10:19:27.461869Z","end":"2026-05-05T10:19:27.71047Z","steps":["trace[1312927084] 'process raft request' (duration: 248.534238ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.710514Z","caller":"traceutil/trace.go:171","msg":"trace[544900273] linearizableReadLoop","detail":"{readStateIndex:245; appliedIndex:244; }","duration":"303.218754ms","start":"2026-05-05T10:19:27.407244Z","end":"2026-05-05T10:19:27.710462Z","steps":["trace[544900273] 'read index received' (duration: 114.336815ms)","trace[544900273] 'applied index is now lower than readState.Index' (duration: 188.880368ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:27.710622Z","caller":"traceutil/trace.go:171","msg":"trace[612610824] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"318.298983ms","start":"2026-05-05T10:19:27.392112Z","end":"2026-05-05T10:19:27.710411Z","steps":["trace[612610824] 'process raft request' (duration: 129.451865ms)","trace[612610824] 'compare' (duration: 188.465957ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:27.710728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.392094Z","time spent":"318.56863ms","remote":"127.0.0.1:53626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":597,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:19:27.711221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.916133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-05T10:19:27.711357Z","caller":"traceutil/trace.go:171","msg":"trace[1265412214] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:239; }","duration":"304.105419ms","start":"2026-05-05T10:19:27.407219Z","end":"2026-05-05T10:19:27.711324Z","steps":["trace[1265412214] 'agreement among raft nodes before linearized reading' (duration: 303.385349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:27.711427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.407207Z","time spent":"304.209612ms","remote":"127.0.0.1:53636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-05T10:19:27.746407Z","caller":"traceutil/trace.go:171","msg":"trace[1750937976] transaction","detail":"{read_only:false; number_of_response:0; response_revision:239; }","duration":"186.359784ms","start":"2026-05-05T10:19:27.560015Z","end":"2026-05-05T10:19:27.746375Z","steps":["trace[1750937976] 'process raft request' (duration: 186.183249ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.746432Z","caller":"traceutil/trace.go:171","msg":"trace[936862328] transaction","detail":"{read_only:false; number_of_response:0; response_revision:239; }","duration":"166.970759ms","start":"2026-05-05T10:19:27.579433Z","end":"2026-05-05T10:19:27.746404Z","steps":["trace[936862328] 'process raft request' (duration: 166.870636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:27.746484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.810766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:27.74651Z","caller":"traceutil/trace.go:171","msg":"trace[542643753] transaction","detail":"{read_only:false; number_of_response:0; response_revision:240; }","duration":"166.846876ms","start":"2026-05-05T10:19:27.579638Z","end":"2026-05-05T10:19:27.746485Z","steps":["trace[542643753] 'process raft request' (duration: 166.736342ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.746559Z","caller":"traceutil/trace.go:171","msg":"trace[1054491063] transaction","detail":"{read_only:false; number_of_response:0; response_revision:240; }","duration":"166.716482ms","start":"2026-05-05T10:19:27.579837Z","end":"2026-05-05T10:19:27.746553Z","steps":["trace[1054491063] 'process raft request' (duration: 166.554577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:27.746657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.920189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-05T10:19:27.746656Z","caller":"traceutil/trace.go:171","msg":"trace[1515769649] transaction","detail":"{read_only:false; number_of_response:0; response_revision:239; }","duration":"167.926347ms","start":"2026-05-05T10:19:27.57872Z","end":"2026-05-05T10:19:27.746646Z","steps":["trace[1515769649] 'process raft request' (duration: 167.565906ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.746684Z","caller":"traceutil/trace.go:171","msg":"trace[1270105990] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:240; }","duration":"284.95421ms","start":"2026-05-05T10:19:27.461723Z","end":"2026-05-05T10:19:27.746677Z","steps":["trace[1270105990] 'agreement among raft nodes before linearized reading' (duration: 284.909689ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.746755Z","caller":"traceutil/trace.go:171","msg":"trace[170281940] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"167.249198ms","start":"2026-05-05T10:19:27.579496Z","end":"2026-05-05T10:19:27.746745Z","steps":["trace[170281940] 'process raft request' (duration: 166.824945ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:27.746532Z","caller":"traceutil/trace.go:171","msg":"trace[1014103620] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:240; }","duration":"284.919219ms","start":"2026-05-05T10:19:27.461598Z","end":"2026-05-05T10:19:27.746517Z","steps":["trace[1014103620] 'agreement among raft nodes before linearized reading' (duration: 284.817205ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:11.086532Z","caller":"traceutil/trace.go:171","msg":"trace[35886634] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:687; }","duration":"137.318629ms","start":"2026-05-05T10:21:10.949159Z","end":"2026-05-05T10:21:11.086478Z","steps":["trace[35886634] 'read index received' (duration: 50.794183ms)","trace[35886634] 'applied index is now lower than readState.Index' (duration: 86.523446ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:11.086559Z","caller":"traceutil/trace.go:171","msg":"trace[2072891579] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"167.647706ms","start":"2026-05-05T10:21:10.918874Z","end":"2026-05-05T10:21:11.086522Z","steps":["trace[2072891579] 'process raft request' (duration: 157.777027ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:11.086663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.475784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:21:11.086698Z","caller":"traceutil/trace.go:171","msg":"trace[1101414996] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:650; }","duration":"137.543436ms","start":"2026-05-05T10:21:10.949143Z","end":"2026-05-05T10:21:11.086687Z","steps":["trace[1101414996] 'agreement among raft nodes before linearized reading' (duration: 137.465644ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:16.168465Z","caller":"traceutil/trace.go:171","msg":"trace[739225579] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"269.195771ms","start":"2026-05-05T10:21:15.899237Z","end":"2026-05-05T10:21:16.168433Z","steps":["trace[739225579] 'process raft request' (duration: 210.246026ms)","trace[739225579] 'compare' (duration: 58.680808ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:16.945132Z","caller":"traceutil/trace.go:171","msg":"trace[754559031] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"134.623916ms","start":"2026-05-05T10:21:16.810487Z","end":"2026-05-05T10:21:16.945111Z","steps":["trace[754559031] 'process raft request' (duration: 134.505803ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:17.167246Z","caller":"traceutil/trace.go:171","msg":"trace[107478677] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"120.282136ms","start":"2026-05-05T10:21:17.046841Z","end":"2026-05-05T10:21:17.167123Z","steps":["trace[107478677] 'process raft request' (duration: 118.302512ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:17.599076Z","caller":"traceutil/trace.go:171","msg":"trace[607692891] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"481.432832ms","start":"2026-05-05T10:21:17.117612Z","end":"2026-05-05T10:21:17.599044Z","steps":["trace[607692891] 'process raft request' (duration: 405.928165ms)","trace[607692891] 'compare' (duration: 75.23846ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:17.599229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:17.117595Z","time spent":"481.555066ms","remote":"127.0.0.1:53790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:21:17.602615Z","caller":"traceutil/trace.go:171","msg":"trace[1068737532] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"429.085176ms","start":"2026-05-05T10:21:17.173504Z","end":"2026-05-05T10:21:17.602589Z","steps":["trace[1068737532] 'process raft request' (duration: 428.922112ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:17.602611Z","caller":"traceutil/trace.go:171","msg":"trace[1184384295] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"374.89633ms","start":"2026-05-05T10:21:17.227686Z","end":"2026-05-05T10:21:17.602582Z","steps":["trace[1184384295] 'process raft request' (duration: 374.848579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:17.602707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:17.173484Z","time spent":"429.177859ms","remote":"127.0.0.1:53790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:17.602755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:17.227661Z","time spent":"375.020124ms","remote":"127.0.0.1:53906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:21:18.96013Z","caller":"traceutil/trace.go:171","msg":"trace[1002699924] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"100.506247ms","start":"2026-05-05T10:21:18.859604Z","end":"2026-05-05T10:21:18.960111Z","steps":["trace[1002699924] 'process raft request' (duration: 80.450641ms)","trace[1002699924] 'compare' (duration: 19.976704ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:18.968044Z","caller":"traceutil/trace.go:171","msg":"trace[476695090] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"107.654203ms","start":"2026-05-05T10:21:18.860363Z","end":"2026-05-05T10:21:18.968018Z","steps":["trace[476695090] 'process raft request' (duration: 107.611392ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:18.968072Z","caller":"traceutil/trace.go:171","msg":"trace[1958034714] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"108.162816ms","start":"2026-05-05T10:21:18.859891Z","end":"2026-05-05T10:21:18.968054Z","steps":["trace[1958034714] 'process raft request' (duration: 107.94556ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:27.017052Z","caller":"traceutil/trace.go:171","msg":"trace[323346053] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"156.265504ms","start":"2026-05-05T10:22:26.860759Z","end":"2026-05-05T10:22:27.017025Z","steps":["trace[323346053] 'process raft request' (duration: 156.036348ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:43.53786Z","caller":"traceutil/trace.go:171","msg":"trace[369579916] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"164.945205ms","start":"2026-05-05T10:22:43.372896Z","end":"2026-05-05T10:22:43.537841Z","steps":["trace[369579916] 'process raft request' (duration: 164.843782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:58.340857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.493591ms","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-05-05T10:22:58.340933Z","caller":"traceutil/trace.go:171","msg":"trace[1271955960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1381; }","duration":"178.642894ms","start":"2026-05-05T10:22:58.162272Z","end":"2026-05-05T10:22:58.340915Z","steps":["trace[1271955960] 'range keys from in-memory index tree' (duration: 178.277174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:58.34116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.100059ms","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-05-05T10:22:58.341287Z","caller":"traceutil/trace.go:171","msg":"trace[1345602391] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1381; }","duration":"175.264304ms","start":"2026-05-05T10:22:58.165994Z","end":"2026-05-05T10:22:58.341259Z","steps":["trace[1345602391] 'range keys from in-memory index tree' (duration: 174.848812ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:58.458701Z","caller":"traceutil/trace.go:171","msg":"trace[1012112796] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"112.49876ms","start":"2026-05-05T10:22:58.346166Z","end":"2026-05-05T10:22:58.458665Z","steps":["trace[1012112796] 'process raft request' (duration: 111.352648ms)"],"step_count":1}