{"level":"warn","ts":"2026-10-20T14:07:04.201835Z","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-20T14:07:04.201904Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.17: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.17:2380","--initial-cluster=instance=https://162.253.55.17:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.17:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.17: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-20T14:07:04.201953Z","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-20T14:07:04.201963Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.17:2380"]} {"level":"info","ts":"2026-10-20T14:07:04.201982Z","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-20T14:07:04.202539Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.17:2379"]} {"level":"info","ts":"2026-10-20T14:07:04.202623Z","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.17:2380"],"listen-peer-urls":["https://162.253.55.17:2380"],"advertise-client-urls":["https://162.253.55.17:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.17:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.17: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-20T14:07:04.208072Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.26918ms"} {"level":"info","ts":"2026-10-20T14:07:04.224185Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9d6ea9653fb28c79","cluster-id":"57f89a414bd43f68"} {"level":"info","ts":"2026-10-20T14:07:04.224233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 switched to configuration voters=()"} {"level":"info","ts":"2026-10-20T14:07:04.224247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 became follower at term 0"} {"level":"info","ts":"2026-10-20T14:07:04.224261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9d6ea9653fb28c79 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-20T14:07:04.224267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 became follower at term 1"} {"level":"info","ts":"2026-10-20T14:07:04.2243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 switched to configuration voters=(11344190763718315129)"} {"level":"warn","ts":"2026-10-20T14:07:04.234942Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-20T14:07:04.23661Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-20T14:07:04.240091Z","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-20T14:07:04.244001Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9d6ea9653fb28c79","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-20T14:07:04.244442Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9d6ea9653fb28c79","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-20T14:07:04.244515Z","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-20T14:07:04.244565Z","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-20T14:07:04.244574Z","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-20T14:07:04.245407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 switched to configuration voters=(11344190763718315129)"} {"level":"info","ts":"2026-10-20T14:07:04.245506Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"57f89a414bd43f68","local-member-id":"9d6ea9653fb28c79","added-peer-id":"9d6ea9653fb28c79","added-peer-peer-urls":["https://162.253.55.17:2380"]} {"level":"info","ts":"2026-10-20T14:07:04.250098Z","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-20T14:07:04.250293Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9d6ea9653fb28c79","initial-advertise-peer-urls":["https://162.253.55.17:2380"],"listen-peer-urls":["https://162.253.55.17:2380"],"advertise-client-urls":["https://162.253.55.17:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.17:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-20T14:07:04.250333Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-20T14:07:04.250462Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.17:2380"} {"level":"info","ts":"2026-10-20T14:07:04.250488Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.17:2380"} {"level":"info","ts":"2026-10-20T14:07:05.025375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 is starting a new election at term 1"} {"level":"info","ts":"2026-10-20T14:07:05.025443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-20T14:07:05.025469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 received MsgPreVoteResp from 9d6ea9653fb28c79 at term 1"} {"level":"info","ts":"2026-10-20T14:07:05.025487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 became candidate at term 2"} {"level":"info","ts":"2026-10-20T14:07:05.025497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 received MsgVoteResp from 9d6ea9653fb28c79 at term 2"} {"level":"info","ts":"2026-10-20T14:07:05.025512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9d6ea9653fb28c79 became leader at term 2"} {"level":"info","ts":"2026-10-20T14:07:05.025524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9d6ea9653fb28c79 elected leader 9d6ea9653fb28c79 at term 2"} {"level":"info","ts":"2026-10-20T14:07:05.026778Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:07:05.0279Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9d6ea9653fb28c79","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.17:2379]}","request-path":"/0/members/9d6ea9653fb28c79/attributes","cluster-id":"57f89a414bd43f68","publish-timeout":"7s"} {"level":"info","ts":"2026-10-20T14:07:05.027926Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-20T14:07:05.028183Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-20T14:07:05.0283Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-20T14:07:05.028352Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-20T14:07:05.028367Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"57f89a414bd43f68","local-member-id":"9d6ea9653fb28c79","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:07:05.02845Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:07:05.028474Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-20T14:07:05.030995Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-20T14:07:05.031586Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.17:2379"} {"level":"info","ts":"2026-10-20T14:07:53.03467Z","caller":"traceutil/trace.go:171","msg":"trace[1298748938] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"194.474566ms","start":"2026-10-20T14:07:52.840157Z","end":"2026-10-20T14:07:53.034632Z","steps":["trace[1298748938] 'process raft request' (duration: 193.637691ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:07:53.288864Z","caller":"traceutil/trace.go:171","msg":"trace[201476917] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"144.223781ms","start":"2026-10-20T14:07:53.144605Z","end":"2026-10-20T14:07:53.288829Z","steps":["trace[201476917] 'read index received' (duration: 54.218814ms)","trace[201476917] 'applied index is now lower than readState.Index' (duration: 90.003237ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:07:53.289034Z","caller":"traceutil/trace.go:171","msg":"trace[297888859] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"176.63982ms","start":"2026-10-20T14:07:53.112348Z","end":"2026-10-20T14:07:53.288988Z","steps":["trace[297888859] 'process raft request' (duration: 86.459539ms)","trace[297888859] 'compare' (duration: 89.830514ms)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:07:53.289195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.557417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8lwqg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-20T14:07:53.289269Z","caller":"traceutil/trace.go:171","msg":"trace[1902007340] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8lwqg; range_end:; response_count:1; response_revision:648; }","duration":"144.70477ms","start":"2026-10-20T14:07:53.14455Z","end":"2026-10-20T14:07:53.289255Z","steps":["trace[1902007340] 'agreement among raft nodes before linearized reading' (duration: 144.413754ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:07:53.933923Z","caller":"traceutil/trace.go:171","msg":"trace[550011407] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"260.114175ms","start":"2026-10-20T14:07:53.673763Z","end":"2026-10-20T14:07:53.933877Z","steps":["trace[550011407] 'process raft request' (duration: 255.316856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:09:07.757349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.232898ms","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-10-20T14:09:07.757475Z","caller":"traceutil/trace.go:171","msg":"trace[2116673194] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1500; }","duration":"130.41411ms","start":"2026-10-20T14:09:07.627032Z","end":"2026-10-20T14:09:07.757446Z","steps":["trace[2116673194] 'range keys from in-memory index tree' (duration: 129.991964ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:09:36.51078Z","caller":"traceutil/trace.go:171","msg":"trace[849691254] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"356.621529ms","start":"2026-10-20T14:09:36.154135Z","end":"2026-10-20T14:09:36.510757Z","steps":["trace[849691254] 'process raft request' (duration: 356.407766ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:09:36.511385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:09:36.154102Z","time spent":"356.761072ms","remote":"127.0.0.1:41882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:09:37.039999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.305145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:09:37.040104Z","caller":"traceutil/trace.go:171","msg":"trace[791623492] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1928; }","duration":"148.504268ms","start":"2026-10-20T14:09:36.891578Z","end":"2026-10-20T14:09:37.040083Z","steps":["trace[791623492] 'count revisions from in-memory index tree' (duration: 148.173613ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:09:51.328915Z","caller":"traceutil/trace.go:171","msg":"trace[370606245] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"113.388144ms","start":"2026-10-20T14:09:51.215499Z","end":"2026-10-20T14:09:51.328887Z","steps":["trace[370606245] 'process raft request' (duration: 113.199157ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:10:12.163885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.790095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-20T14:10:12.164112Z","caller":"traceutil/trace.go:171","msg":"trace[1968026917] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"192.55199ms","start":"2026-10-20T14:10:11.971541Z","end":"2026-10-20T14:10:12.164093Z","steps":["trace[1968026917] 'process raft request' (duration: 192.512428ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:10:12.164153Z","caller":"traceutil/trace.go:171","msg":"trace[107726281] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"193.421481ms","start":"2026-10-20T14:10:11.970659Z","end":"2026-10-20T14:10:12.16408Z","steps":["trace[107726281] 'process raft request' (duration: 68.19331ms)","trace[107726281] 'compare' (duration: 124.693151ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:10:12.164305Z","caller":"traceutil/trace.go:171","msg":"trace[559970915] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"193.149091ms","start":"2026-10-20T14:10:11.971121Z","end":"2026-10-20T14:10:12.16427Z","steps":["trace[559970915] 'process raft request' (duration: 192.874371ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:10:12.215395Z","caller":"traceutil/trace.go:171","msg":"trace[1314624892] linearizableReadLoop","detail":"{readStateIndex:2265; appliedIndex:2264; }","duration":"105.058955ms","start":"2026-10-20T14:10:12.110313Z","end":"2026-10-20T14:10:12.215372Z","steps":["trace[1314624892] 'read index received' (duration: 104.873738ms)","trace[1314624892] 'applied index is now lower than readState.Index' (duration: 184.176µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:10:12.215498Z","caller":"traceutil/trace.go:171","msg":"trace[1025743328] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"168.480119ms","start":"2026-10-20T14:10:12.046985Z","end":"2026-10-20T14:10:12.215465Z","steps":["trace[1025743328] 'process raft request' (duration: 168.269491ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:10:12.215618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.286463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-10-20T14:10:12.215666Z","caller":"traceutil/trace.go:171","msg":"trace[1101855994] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2180; }","duration":"105.402998ms","start":"2026-10-20T14:10:12.110252Z","end":"2026-10-20T14:10:12.215655Z","steps":["trace[1101855994] 'agreement among raft nodes before linearized reading' (duration: 105.206561ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:10:13.675844Z","caller":"traceutil/trace.go:171","msg":"trace[302772735] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"296.624796ms","start":"2026-10-20T14:10:13.379175Z","end":"2026-10-20T14:10:13.6758Z","steps":["trace[302772735] 'process raft request' (duration: 296.365796ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:10:13.691929Z","caller":"traceutil/trace.go:171","msg":"trace[1429146697] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"267.038203ms","start":"2026-10-20T14:10:13.424845Z","end":"2026-10-20T14:10:13.691884Z","steps":["trace[1429146697] 'process raft request' (duration: 266.579167ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:10:13.905413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.814343ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-20T14:10:13.906041Z","caller":"traceutil/trace.go:171","msg":"trace[1291971259] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"222.740974ms","start":"2026-10-20T14:10:13.683262Z","end":"2026-10-20T14:10:13.906003Z","steps":["trace[1291971259] 'process raft request' (duration: 222.301838ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:12:05.892699Z","caller":"traceutil/trace.go:171","msg":"trace[1873337680] transaction","detail":"{read_only:false; response_revision:2893; number_of_response:1; }","duration":"115.294546ms","start":"2026-10-20T14:12:05.777367Z","end":"2026-10-20T14:12:05.892662Z","steps":["trace[1873337680] 'process raft request' (duration: 115.029739ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:12:11.318196Z","caller":"traceutil/trace.go:171","msg":"trace[1725010535] transaction","detail":"{read_only:false; response_revision:2924; number_of_response:1; }","duration":"149.769601ms","start":"2026-10-20T14:12:11.168396Z","end":"2026-10-20T14:12:11.318166Z","steps":["trace[1725010535] 'process raft request' (duration: 149.474963ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:16:42.178963Z","caller":"traceutil/trace.go:171","msg":"trace[1051543190] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"110.228498ms","start":"2026-10-20T14:16:42.068697Z","end":"2026-10-20T14:16:42.178925Z","steps":["trace[1051543190] 'process raft request' (duration: 60.753436ms)","trace[1051543190] 'compare' (duration: 49.265328ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:16:42.179136Z","caller":"traceutil/trace.go:171","msg":"trace[941710158] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"104.78731ms","start":"2026-10-20T14:16:42.074328Z","end":"2026-10-20T14:16:42.179115Z","steps":["trace[941710158] 'process raft request' (duration: 104.555445ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:16:42.841041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.474226ms","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-20T14:16:42.841156Z","caller":"traceutil/trace.go:171","msg":"trace[1237712467] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:5036; }","duration":"164.62155ms","start":"2026-10-20T14:16:42.67651Z","end":"2026-10-20T14:16:42.841131Z","steps":["trace[1237712467] 'count revisions from in-memory index tree' (duration: 164.394344ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:16:49.448796Z","caller":"traceutil/trace.go:171","msg":"trace[2013545177] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"110.268534ms","start":"2026-10-20T14:16:49.338478Z","end":"2026-10-20T14:16:49.448747Z","steps":["trace[2013545177] 'process raft request' (duration: 110.06972ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:16:52.442387Z","caller":"traceutil/trace.go:171","msg":"trace[1077396339] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"118.791404ms","start":"2026-10-20T14:16:52.323558Z","end":"2026-10-20T14:16:52.442349Z","steps":["trace[1077396339] 'process raft request' (duration: 118.433777ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:17:03.246855Z","caller":"traceutil/trace.go:171","msg":"trace[2072260085] linearizableReadLoop","detail":"{readStateIndex:5524; appliedIndex:5523; }","duration":"345.069875ms","start":"2026-10-20T14:17:02.901749Z","end":"2026-10-20T14:17:03.246819Z","steps":["trace[2072260085] 'read index received' (duration: 344.79968ms)","trace[2072260085] 'applied index is now lower than readState.Index' (duration: 268.745µs)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:17:03.24692Z","caller":"traceutil/trace.go:171","msg":"trace[1165265180] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"349.503823ms","start":"2026-10-20T14:17:02.89737Z","end":"2026-10-20T14:17:03.246874Z","steps":["trace[1165265180] 'process raft request' (duration: 349.207847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:17:03.24714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:17:02.897355Z","time spent":"349.683727ms","remote":"127.0.0.1:41722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-20T14:17:03.247155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.347989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-20T14:17:03.247158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.372211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9785"} {"level":"info","ts":"2026-10-20T14:17:03.24725Z","caller":"traceutil/trace.go:171","msg":"trace[583973384] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5320; }","duration":"345.495543ms","start":"2026-10-20T14:17:02.901729Z","end":"2026-10-20T14:17:03.247225Z","steps":["trace[583973384] 'agreement among raft nodes before linearized reading' (duration: 345.213407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:17:03.247291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-20T14:17:02.90172Z","time spent":"345.563784ms","remote":"127.0.0.1:42074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9808,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"info","ts":"2026-10-20T14:17:03.247202Z","caller":"traceutil/trace.go:171","msg":"trace[483437493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5320; }","duration":"242.44942ms","start":"2026-10-20T14:17:03.004735Z","end":"2026-10-20T14:17:03.247185Z","steps":["trace[483437493] 'agreement among raft nodes before linearized reading' (duration: 242.300677ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:17:05.05925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2891} {"level":"info","ts":"2026-10-20T14:17:05.154747Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2891,"took":"93.297059ms","hash":3129855085,"current-db-size-bytes":51793920,"current-db-size":"52 MB","current-db-size-in-use-bytes":27697152,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-20T14:17:05.154865Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3129855085,"revision":2891,"compact-revision":-1} {"level":"info","ts":"2026-10-20T14:18:33.243833Z","caller":"traceutil/trace.go:171","msg":"trace[398407647] transaction","detail":"{read_only:false; response_revision:6039; number_of_response:1; }","duration":"113.927718ms","start":"2026-10-20T14:18:33.129875Z","end":"2026-10-20T14:18:33.243803Z","steps":["trace[398407647] 'process raft request' (duration: 35.716412ms)","trace[398407647] 'compare' (duration: 78.103532ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:33.292444Z","caller":"traceutil/trace.go:171","msg":"trace[911284496] transaction","detail":"{read_only:false; response_revision:6040; number_of_response:1; }","duration":"161.566011ms","start":"2026-10-20T14:18:33.130853Z","end":"2026-10-20T14:18:33.292419Z","steps":["trace[911284496] 'process raft request' (duration: 161.392365ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:33.292662Z","caller":"traceutil/trace.go:171","msg":"trace[1358763998] transaction","detail":"{read_only:false; response_revision:6041; number_of_response:1; }","duration":"159.361519ms","start":"2026-10-20T14:18:33.133253Z","end":"2026-10-20T14:18:33.292614Z","steps":["trace[1358763998] 'process raft request' (duration: 159.127261ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:34.155043Z","caller":"traceutil/trace.go:171","msg":"trace[1868043180] transaction","detail":"{read_only:false; response_revision:6045; number_of_response:1; }","duration":"109.437735ms","start":"2026-10-20T14:18:34.045581Z","end":"2026-10-20T14:18:34.155019Z","steps":["trace[1868043180] 'process raft request' (duration: 109.27064ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:34.294928Z","caller":"traceutil/trace.go:171","msg":"trace[1119350210] transaction","detail":"{read_only:false; response_revision:6047; number_of_response:1; }","duration":"105.324652ms","start":"2026-10-20T14:18:34.189551Z","end":"2026-10-20T14:18:34.294876Z","steps":["trace[1119350210] 'process raft request' (duration: 61.979011ms)","trace[1119350210] 'compare' (duration: 43.066832ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:35.164933Z","caller":"traceutil/trace.go:171","msg":"trace[179539219] transaction","detail":"{read_only:false; response_revision:6053; number_of_response:1; }","duration":"109.583635ms","start":"2026-10-20T14:18:35.055307Z","end":"2026-10-20T14:18:35.164891Z","steps":["trace[179539219] 'process raft request' (duration: 109.390419ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:35.269713Z","caller":"traceutil/trace.go:171","msg":"trace[124125099] transaction","detail":"{read_only:false; response_revision:6055; number_of_response:1; }","duration":"101.003834ms","start":"2026-10-20T14:18:35.168685Z","end":"2026-10-20T14:18:35.269689Z","steps":["trace[124125099] 'process raft request' (duration: 70.122694ms)","trace[124125099] 'compare' (duration: 30.768717ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:35.417417Z","caller":"traceutil/trace.go:171","msg":"trace[764614506] transaction","detail":"{read_only:false; response_revision:6059; number_of_response:1; }","duration":"137.338793ms","start":"2026-10-20T14:18:35.28005Z","end":"2026-10-20T14:18:35.417388Z","steps":["trace[764614506] 'process raft request' (duration: 137.220229ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:35.417426Z","caller":"traceutil/trace.go:171","msg":"trace[1480063251] linearizableReadLoop","detail":"{readStateIndex:6285; appliedIndex:6285; }","duration":"130.396416ms","start":"2026-10-20T14:18:35.286997Z","end":"2026-10-20T14:18:35.417394Z","steps":["trace[1480063251] 'read index received' (duration: 130.369035ms)","trace[1480063251] 'applied index is now lower than readState.Index' (duration: 25.141µs)"],"step_count":2} {"level":"warn","ts":"2026-10-20T14:18:35.41759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.133283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:18:35.417646Z","caller":"traceutil/trace.go:171","msg":"trace[1411563512] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:6059; }","duration":"165.249017ms","start":"2026-10-20T14:18:35.252385Z","end":"2026-10-20T14:18:35.417634Z","steps":["trace[1411563512] 'agreement among raft nodes before linearized reading' (duration: 165.108482ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:35.447686Z","caller":"traceutil/trace.go:171","msg":"trace[1703018208] transaction","detail":"{read_only:false; response_revision:6060; number_of_response:1; }","duration":"155.938961ms","start":"2026-10-20T14:18:35.291674Z","end":"2026-10-20T14:18:35.447613Z","steps":["trace[1703018208] 'process raft request' (duration: 155.714274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:18:35.44774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.093102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-10-20T14:18:35.447745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.271359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-20T14:18:35.447824Z","caller":"traceutil/trace.go:171","msg":"trace[641279147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6060; }","duration":"151.378892ms","start":"2026-10-20T14:18:35.296427Z","end":"2026-10-20T14:18:35.447806Z","steps":["trace[641279147] 'agreement among raft nodes before linearized reading' (duration: 151.201806ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:35.447818Z","caller":"traceutil/trace.go:171","msg":"trace[1714496830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6060; }","duration":"147.426803ms","start":"2026-10-20T14:18:35.300369Z","end":"2026-10-20T14:18:35.447796Z","steps":["trace[1714496830] 'agreement among raft nodes before linearized reading' (duration: 147.197415ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:35.633757Z","caller":"traceutil/trace.go:171","msg":"trace[916058422] transaction","detail":"{read_only:false; response_revision:6064; number_of_response:1; }","duration":"108.405697ms","start":"2026-10-20T14:18:35.525324Z","end":"2026-10-20T14:18:35.63373Z","steps":["trace[916058422] 'process raft request' (duration: 108.120027ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:38.271566Z","caller":"traceutil/trace.go:171","msg":"trace[1144305586] transaction","detail":"{read_only:false; response_revision:6089; number_of_response:1; }","duration":"188.153789ms","start":"2026-10-20T14:18:38.083385Z","end":"2026-10-20T14:18:38.271539Z","steps":["trace[1144305586] 'process raft request' (duration: 150.868375ms)","trace[1144305586] 'compare' (duration: 37.207622ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:38.43759Z","caller":"traceutil/trace.go:171","msg":"trace[760179856] transaction","detail":"{read_only:false; response_revision:6091; number_of_response:1; }","duration":"109.050103ms","start":"2026-10-20T14:18:38.328515Z","end":"2026-10-20T14:18:38.437565Z","steps":["trace[760179856] 'process raft request' (duration: 45.297416ms)","trace[760179856] 'compare' (duration: 63.640423ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:40.28907Z","caller":"traceutil/trace.go:171","msg":"trace[2026052582] transaction","detail":"{read_only:false; response_revision:6099; number_of_response:1; }","duration":"121.152956ms","start":"2026-10-20T14:18:40.167891Z","end":"2026-10-20T14:18:40.289044Z","steps":["trace[2026052582] 'process raft request' (duration: 120.996901ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:41.523953Z","caller":"traceutil/trace.go:171","msg":"trace[2051988191] transaction","detail":"{read_only:false; response_revision:6105; number_of_response:1; }","duration":"117.7495ms","start":"2026-10-20T14:18:41.406183Z","end":"2026-10-20T14:18:41.523932Z","steps":["trace[2051988191] 'process raft request' (duration: 117.634677ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:42.493228Z","caller":"traceutil/trace.go:171","msg":"trace[1000617620] transaction","detail":"{read_only:false; response_revision:6110; number_of_response:1; }","duration":"106.506ms","start":"2026-10-20T14:18:42.386693Z","end":"2026-10-20T14:18:42.493199Z","steps":["trace[1000617620] 'process raft request' (duration: 45.65333ms)","trace[1000617620] 'compare' (duration: 60.691925ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:45.318Z","caller":"traceutil/trace.go:171","msg":"trace[1371904682] transaction","detail":"{read_only:false; response_revision:6122; number_of_response:1; }","duration":"217.869269ms","start":"2026-10-20T14:18:45.100106Z","end":"2026-10-20T14:18:45.317975Z","steps":["trace[1371904682] 'process raft request' (duration: 217.719354ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:47.650682Z","caller":"traceutil/trace.go:171","msg":"trace[475704026] transaction","detail":"{read_only:false; response_revision:6133; number_of_response:1; }","duration":"154.653035ms","start":"2026-10-20T14:18:47.495997Z","end":"2026-10-20T14:18:47.65065Z","steps":["trace[475704026] 'process raft request' (duration: 154.450779ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:48.51093Z","caller":"traceutil/trace.go:171","msg":"trace[821871654] transaction","detail":"{read_only:false; response_revision:6139; number_of_response:1; }","duration":"117.758674ms","start":"2026-10-20T14:18:48.393139Z","end":"2026-10-20T14:18:48.510898Z","steps":["trace[821871654] 'process raft request' (duration: 117.546346ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:50.622875Z","caller":"traceutil/trace.go:171","msg":"trace[622405125] transaction","detail":"{read_only:false; response_revision:6149; number_of_response:1; }","duration":"105.987365ms","start":"2026-10-20T14:18:50.516862Z","end":"2026-10-20T14:18:50.622849Z","steps":["trace[622405125] 'process raft request' (duration: 105.780509ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:50.72322Z","caller":"traceutil/trace.go:171","msg":"trace[1447662318] linearizableReadLoop","detail":"{readStateIndex:6379; appliedIndex:6378; }","duration":"100.379297ms","start":"2026-10-20T14:18:50.622814Z","end":"2026-10-20T14:18:50.723194Z","steps":["trace[1447662318] 'read index received' (duration: 97.36506ms)","trace[1447662318] 'applied index is now lower than readState.Index' (duration: 3.012777ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:18:50.72331Z","caller":"traceutil/trace.go:171","msg":"trace[2017981067] transaction","detail":"{read_only:false; response_revision:6150; number_of_response:1; }","duration":"110.18708ms","start":"2026-10-20T14:18:50.613091Z","end":"2026-10-20T14:18:50.723278Z","steps":["trace[2017981067] 'process raft request' (duration: 107.076181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-20T14:18:50.723363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.838147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-20T14:18:50.723463Z","caller":"traceutil/trace.go:171","msg":"trace[1043120721] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:6150; }","duration":"113.997042ms","start":"2026-10-20T14:18:50.609428Z","end":"2026-10-20T14:18:50.723425Z","steps":["trace[1043120721] 'agreement among raft nodes before linearized reading' (duration: 113.844957ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:18:54.902717Z","caller":"traceutil/trace.go:171","msg":"trace[1131729264] transaction","detail":"{read_only:false; response_revision:6172; number_of_response:1; }","duration":"128.913578ms","start":"2026-10-20T14:18:54.77377Z","end":"2026-10-20T14:18:54.902683Z","steps":["trace[1131729264] 'process raft request' (duration: 92.424615ms)","trace[1131729264] 'compare' (duration: 36.260696ms)"],"step_count":2} {"level":"info","ts":"2026-10-20T14:20:41.27778Z","caller":"traceutil/trace.go:171","msg":"trace[1727185600] transaction","detail":"{read_only:false; response_revision:6909; number_of_response:1; }","duration":"103.392446ms","start":"2026-10-20T14:20:41.174358Z","end":"2026-10-20T14:20:41.277751Z","steps":["trace[1727185600] 'process raft request' (duration: 103.203771ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:20:41.293313Z","caller":"traceutil/trace.go:171","msg":"trace[513979194] transaction","detail":"{read_only:false; response_revision:6910; number_of_response:1; }","duration":"106.375869ms","start":"2026-10-20T14:20:41.186904Z","end":"2026-10-20T14:20:41.29328Z","steps":["trace[513979194] 'process raft request' (duration: 106.229735ms)"],"step_count":1} {"level":"info","ts":"2026-10-20T14:22:05.068649Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5340} {"level":"info","ts":"2026-10-20T14:22:05.168091Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5340,"took":"97.844081ms","hash":3914093418,"current-db-size-bytes":51793920,"current-db-size":"52 MB","current-db-size-in-use-bytes":19169280,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-20T14:22:05.168173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3914093418,"revision":5340,"compact-revision":2891}