{"level":"warn","ts":"2026-09-12T04:03:09.789928Z","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-12T04:03:09.790255Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-12T04:03:09.790404Z","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-12T04:03:09.790421Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-12T04:03:09.790441Z","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-12T04:03:09.791062Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-09-12T04:03:09.79114Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-12T04:03:09.795907Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.545186ms"} {"level":"info","ts":"2026-09-12T04:03:09.811616Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-09-12T04:03:09.811727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T04:03:09.811754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-09-12T04:03:09.811785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T04:03:09.811792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-09-12T04:03:09.811835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-09-12T04:03:09.822702Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T04:03:09.823851Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T04:03:09.825161Z","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-12T04:03:09.826912Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T04:03:09.829759Z","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-12T04:03:09.829832Z","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-12T04:03:09.829844Z","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-12T04:03:09.83097Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T04:03:09.832162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-09-12T04:03:09.832431Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-12T04:03:09.833328Z","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-12T04:03:09.833486Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T04:03:09.83351Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T04:03:09.833616Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-12T04:03:09.833628Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-12T04:03:10.612594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T04:03:10.612677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T04:03:10.612703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-09-12T04:03:10.612723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-09-12T04:03:10.612734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-12T04:03:10.61275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-09-12T04:03:10.612763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-12T04:03:10.614328Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:03:10.614562Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T04:03:10.614549Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T04:03:10.614503Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T04:03:10.61605Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T04:03:10.618985Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T04:03:10.618126Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-09-12T04:03:10.618308Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-12T04:03:10.629402Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:03:10.62993Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:03:10.630385Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T04:03:13.390005Z","caller":"traceutil/trace.go:171","msg":"trace[1913686330] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"106.725808ms","start":"2026-09-12T04:03:13.283201Z","end":"2026-09-12T04:03:13.389927Z","steps":["trace[1913686330] 'process raft request' (duration: 102.254123ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:20.968024Z","caller":"traceutil/trace.go:171","msg":"trace[1076443906] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"134.870412ms","start":"2026-09-12T04:03:20.833125Z","end":"2026-09-12T04:03:20.967995Z","steps":["trace[1076443906] 'process raft request' (duration: 134.70849ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:21.540955Z","caller":"traceutil/trace.go:171","msg":"trace[1222264325] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"266.892306ms","start":"2026-09-12T04:03:21.274042Z","end":"2026-09-12T04:03:21.540934Z","steps":["trace[1222264325] 'process raft request' (duration: 266.784615ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:21.661898Z","caller":"traceutil/trace.go:171","msg":"trace[2012697893] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"112.655983ms","start":"2026-09-12T04:03:21.549212Z","end":"2026-09-12T04:03:21.661868Z","steps":["trace[2012697893] 'process raft request' (duration: 112.51175ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:21.66317Z","caller":"traceutil/trace.go:171","msg":"trace[940305910] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"112.762253ms","start":"2026-09-12T04:03:21.55038Z","end":"2026-09-12T04:03:21.663142Z","steps":["trace[940305910] 'process raft request' (duration: 112.621191ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:59.507325Z","caller":"traceutil/trace.go:171","msg":"trace[1087999962] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"142.48534ms","start":"2026-09-12T04:03:59.364818Z","end":"2026-09-12T04:03:59.507304Z","steps":["trace[1087999962] 'process raft request' (duration: 129.836269ms)","trace[1087999962] 'compare' (duration: 12.55296ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:03:59.509656Z","caller":"traceutil/trace.go:171","msg":"trace[1727617467] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"139.982921ms","start":"2026-09-12T04:03:59.369638Z","end":"2026-09-12T04:03:59.509621Z","steps":["trace[1727617467] 'process raft request' (duration: 139.735408ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:59.50983Z","caller":"traceutil/trace.go:171","msg":"trace[1110242361] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"135.74644ms","start":"2026-09-12T04:03:59.374061Z","end":"2026-09-12T04:03:59.509807Z","steps":["trace[1110242361] 'process raft request' (duration: 135.430826ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:03:59.510649Z","caller":"traceutil/trace.go:171","msg":"trace[1619257132] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"133.683765ms","start":"2026-09-12T04:03:59.376951Z","end":"2026-09-12T04:03:59.510635Z","steps":["trace[1619257132] 'process raft request' (duration: 132.632952ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:00.978715Z","caller":"traceutil/trace.go:171","msg":"trace[826062179] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"102.154319ms","start":"2026-09-12T04:04:00.876536Z","end":"2026-09-12T04:04:00.97869Z","steps":["trace[826062179] 'read index received' (duration: 101.557991ms)","trace[826062179] 'applied index is now lower than readState.Index' (duration: 595.098µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:04:00.978774Z","caller":"traceutil/trace.go:171","msg":"trace[1773939741] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"110.745082ms","start":"2026-09-12T04:04:00.867998Z","end":"2026-09-12T04:04:00.978743Z","steps":["trace[1773939741] 'process raft request' (duration: 110.314156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:00.97903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.429982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T04:04:00.979225Z","caller":"traceutil/trace.go:171","msg":"trace[960575222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:660; }","duration":"102.692655ms","start":"2026-09-12T04:04:00.876502Z","end":"2026-09-12T04:04:00.979195Z","steps":["trace[960575222] 'agreement among raft nodes before linearized reading' (duration: 102.27836ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:01.189875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.111557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:9149"} {"level":"info","ts":"2026-09-12T04:04:01.189949Z","caller":"traceutil/trace.go:171","msg":"trace[571334686] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:661; }","duration":"133.194408ms","start":"2026-09-12T04:04:01.056735Z","end":"2026-09-12T04:04:01.189929Z","steps":["trace[571334686] 'range keys from in-memory index tree' (duration: 132.985856ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:01.190357Z","caller":"traceutil/trace.go:171","msg":"trace[1395771225] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"130.228174ms","start":"2026-09-12T04:04:01.060102Z","end":"2026-09-12T04:04:01.19033Z","steps":["trace[1395771225] 'process raft request' (duration: 129.743137ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:04.802886Z","caller":"traceutil/trace.go:171","msg":"trace[201845761] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"201.612394ms","start":"2026-09-12T04:04:04.601249Z","end":"2026-09-12T04:04:04.802861Z","steps":["trace[201845761] 'process raft request' (duration: 201.440072ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:04.81188Z","caller":"traceutil/trace.go:171","msg":"trace[661219154] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:724; }","duration":"181.15521ms","start":"2026-09-12T04:04:04.6307Z","end":"2026-09-12T04:04:04.811855Z","steps":["trace[661219154] 'read index received' (duration: 171.981151ms)","trace[661219154] 'applied index is now lower than readState.Index' (duration: 9.173029ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:04:04.811974Z","caller":"traceutil/trace.go:171","msg":"trace[312111161] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"182.00483ms","start":"2026-09-12T04:04:04.62992Z","end":"2026-09-12T04:04:04.811925Z","steps":["trace[312111161] 'process raft request' (duration: 181.818077ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.812047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.324502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-12T04:04:04.81208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.326252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812145Z","caller":"traceutil/trace.go:171","msg":"trace[1416047026] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:700; }","duration":"181.383342ms","start":"2026-09-12T04:04:04.630686Z","end":"2026-09-12T04:04:04.812069Z","steps":["trace[1416047026] 'agreement among raft nodes before linearized reading' (duration: 181.300761ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:04.812196Z","caller":"traceutil/trace.go:171","msg":"trace[204635888] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:700; }","duration":"181.495213ms","start":"2026-09-12T04:04:04.630653Z","end":"2026-09-12T04:04:04.812148Z","steps":["trace[204635888] 'agreement among raft nodes before linearized reading' (duration: 181.25902ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.812358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.204561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-12T04:04:04.812363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.681215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812387Z","caller":"traceutil/trace.go:171","msg":"trace[1075687621] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:700; }","duration":"150.238102ms","start":"2026-09-12T04:04:04.662141Z","end":"2026-09-12T04:04:04.812379Z","steps":["trace[1075687621] 'agreement among raft nodes before linearized reading' (duration: 150.182091ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:04.81241Z","caller":"traceutil/trace.go:171","msg":"trace[1231696558] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:700; }","duration":"139.736477ms","start":"2026-09-12T04:04:04.672656Z","end":"2026-09-12T04:04:04.812393Z","steps":["trace[1231696558] 'agreement among raft nodes before linearized reading' (duration: 139.640476ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.812092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.607963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812462Z","caller":"traceutil/trace.go:171","msg":"trace[215999367] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:700; }","duration":"181.013718ms","start":"2026-09-12T04:04:04.631428Z","end":"2026-09-12T04:04:04.812442Z","steps":["trace[215999367] 'agreement among raft nodes before linearized reading' (duration: 180.620233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.812478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.567613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812528Z","caller":"traceutil/trace.go:171","msg":"trace[1003912647] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:700; }","duration":"154.640734ms","start":"2026-09-12T04:04:04.657871Z","end":"2026-09-12T04:04:04.812511Z","steps":["trace[1003912647] 'agreement among raft nodes before linearized reading' (duration: 154.551723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.81264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.335693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812664Z","caller":"traceutil/trace.go:171","msg":"trace[1412451938] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:700; }","duration":"140.375044ms","start":"2026-09-12T04:04:04.672281Z","end":"2026-09-12T04:04:04.812656Z","steps":["trace[1412451938] 'agreement among raft nodes before linearized reading' (duration: 140.334133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.812749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.820187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812796Z","caller":"traceutil/trace.go:171","msg":"trace[569462476] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:700; }","duration":"154.878897ms","start":"2026-09-12T04:04:04.657903Z","end":"2026-09-12T04:04:04.812782Z","steps":["trace[569462476] 'agreement among raft nodes before linearized reading' (duration: 154.800866ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:04.812835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.564066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:04:04.812859Z","caller":"traceutil/trace.go:171","msg":"trace[55040072] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:700; }","duration":"140.605566ms","start":"2026-09-12T04:04:04.672246Z","end":"2026-09-12T04:04:04.812851Z","steps":["trace[55040072] 'agreement among raft nodes before linearized reading' (duration: 140.566155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:08.632841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.066532ms","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-09-12T04:04:08.632994Z","caller":"traceutil/trace.go:171","msg":"trace[2121368838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:726; }","duration":"189.308176ms","start":"2026-09-12T04:04:08.443653Z","end":"2026-09-12T04:04:08.632961Z","steps":["trace[2121368838] 'range keys from in-memory index tree' (duration: 188.8341ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:04:08.632862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.15484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c2b72\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-12T04:04:08.63312Z","caller":"traceutil/trace.go:171","msg":"trace[186052780] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c2b72; range_end:; response_count:1; response_revision:726; }","duration":"240.471564ms","start":"2026-09-12T04:04:08.392627Z","end":"2026-09-12T04:04:08.633099Z","steps":["trace[186052780] 'range keys from in-memory index tree' (duration: 239.867618ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:04:26.290154Z","caller":"traceutil/trace.go:171","msg":"trace[143869617] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"143.318545ms","start":"2026-09-12T04:04:26.146806Z","end":"2026-09-12T04:04:26.290124Z","steps":["trace[143869617] 'process raft request' (duration: 143.051251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:45.932417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.027101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-09-12T04:05:45.932479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.379249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-12T04:05:45.932526Z","caller":"traceutil/trace.go:171","msg":"trace[141131048] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1911; }","duration":"126.44528ms","start":"2026-09-12T04:05:45.806068Z","end":"2026-09-12T04:05:45.932513Z","steps":["trace[141131048] 'range keys from in-memory index tree' (duration: 126.284738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:45.932576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.965543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:05:45.932609Z","caller":"traceutil/trace.go:171","msg":"trace[837491371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1911; }","duration":"200.035764ms","start":"2026-09-12T04:05:45.732563Z","end":"2026-09-12T04:05:45.932598Z","steps":["trace[837491371] 'range keys from in-memory index tree' (duration: 199.910703ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:45.93252Z","caller":"traceutil/trace.go:171","msg":"trace[1695940669] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1911; }","duration":"150.177032ms","start":"2026-09-12T04:05:45.78232Z","end":"2026-09-12T04:05:45.932497Z","steps":["trace[1695940669] 'range keys from in-memory index tree' (duration: 149.858648ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:46.139724Z","caller":"traceutil/trace.go:171","msg":"trace[75650917] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"201.178957ms","start":"2026-09-12T04:05:45.938227Z","end":"2026-09-12T04:05:46.139406Z","steps":["trace[75650917] 'process raft request' (duration: 200.977725ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:46.45227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.294488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:05:46.452507Z","caller":"traceutil/trace.go:171","msg":"trace[532911443] linearizableReadLoop","detail":"{readStateIndex:1991; appliedIndex:1987; }","duration":"342.228731ms","start":"2026-09-12T04:05:46.110262Z","end":"2026-09-12T04:05:46.45249Z","steps":["trace[532911443] 'read index received' (duration: 29.011505ms)","trace[532911443] 'applied index is now lower than readState.Index' (duration: 313.216336ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:05:46.452597Z","caller":"traceutil/trace.go:171","msg":"trace[5394464] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"478.572468ms","start":"2026-09-12T04:05:45.974015Z","end":"2026-09-12T04:05:46.452587Z","steps":["trace[5394464] 'process raft request' (duration: 478.363626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:46.452661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:05:45.973997Z","time spent":"478.627198ms","remote":"127.0.0.1:47478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T04:05:46.452895Z","caller":"traceutil/trace.go:171","msg":"trace[303821636] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"510.741741ms","start":"2026-09-12T04:05:45.942135Z","end":"2026-09-12T04:05:46.452876Z","steps":["trace[303821636] 'process raft request' (duration: 405.088437ms)","trace[303821636] 'compare' (duration: 104.179057ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:05:46.452982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:05:45.942121Z","time spent":"510.819342ms","remote":"127.0.0.1:47388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:05:46.453209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.093851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5d4cd224-e3d3-41ee-abc8-2fef02c64c0d\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-09-12T04:05:46.454622Z","caller":"traceutil/trace.go:171","msg":"trace[1960251602] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5d4cd224-e3d3-41ee-abc8-2fef02c64c0d; range_end:; response_count:1; response_revision:1915; }","duration":"231.561938ms","start":"2026-09-12T04:05:46.223033Z","end":"2026-09-12T04:05:46.454595Z","steps":["trace[1960251602] 'agreement among raft nodes before linearized reading' (duration: 230.092611ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:05:46.453271Z","caller":"traceutil/trace.go:171","msg":"trace[114342220] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"428.705447ms","start":"2026-09-12T04:05:46.024541Z","end":"2026-09-12T04:05:46.453247Z","steps":["trace[114342220] 'process raft request' (duration: 427.909427ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:46.454926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:05:46.024526Z","time spent":"430.340646ms","remote":"127.0.0.1:47478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:05:46.453224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.92778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-12T04:05:46.455057Z","caller":"traceutil/trace.go:171","msg":"trace[124608872] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1915; }","duration":"344.852222ms","start":"2026-09-12T04:05:46.110182Z","end":"2026-09-12T04:05:46.455035Z","steps":["trace[124608872] 'agreement among raft nodes before linearized reading' (duration: 342.698847ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:05:46.455189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:05:46.11016Z","time spent":"345.007504ms","remote":"127.0.0.1:47478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-12T04:05:46.618986Z","caller":"traceutil/trace.go:171","msg":"trace[66261232] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"157.731301ms","start":"2026-09-12T04:05:46.461216Z","end":"2026-09-12T04:05:46.618948Z","steps":["trace[66261232] 'process raft request' (duration: 122.407242ms)","trace[66261232] 'compare' (duration: 34.717332ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:06:19.936694Z","caller":"traceutil/trace.go:171","msg":"trace[679558409] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2237; }","duration":"202.593292ms","start":"2026-09-12T04:06:19.734068Z","end":"2026-09-12T04:06:19.936661Z","steps":["trace[679558409] 'read index received' (duration: 189.240115ms)","trace[679558409] 'applied index is now lower than readState.Index' (duration: 13.352477ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:06:19.936732Z","caller":"traceutil/trace.go:171","msg":"trace[2083901375] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"220.990502ms","start":"2026-09-12T04:06:19.715706Z","end":"2026-09-12T04:06:19.936696Z","steps":["trace[2083901375] 'process raft request' (duration: 207.588552ms)","trace[2083901375] 'compare' (duration: 13.006904ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:06:19.936797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.724956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T04:06:19.936814Z","caller":"traceutil/trace.go:171","msg":"trace[834835309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"202.756686ms","start":"2026-09-12T04:06:19.734052Z","end":"2026-09-12T04:06:19.936809Z","steps":["trace[834835309] 'agreement among raft nodes before linearized reading' (duration: 202.707386ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:06:19.975338Z","caller":"traceutil/trace.go:171","msg":"trace[884422164] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"129.156232ms","start":"2026-09-12T04:06:19.846152Z","end":"2026-09-12T04:06:19.975308Z","steps":["trace[884422164] 'process raft request' (duration: 129.019711ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:06:19.975513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.196399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T04:06:19.975594Z","caller":"traceutil/trace.go:171","msg":"trace[1979813205] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2155; }","duration":"116.32564ms","start":"2026-09-12T04:06:19.859248Z","end":"2026-09-12T04:06:19.975574Z","steps":["trace[1979813205] 'agreement among raft nodes before linearized reading' (duration: 116.121838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:06:19.975886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.540808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T04:06:19.976009Z","caller":"traceutil/trace.go:171","msg":"trace[239726651] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2155; }","duration":"183.70781ms","start":"2026-09-12T04:06:19.792281Z","end":"2026-09-12T04:06:19.975988Z","steps":["trace[239726651] 'agreement among raft nodes before linearized reading' (duration: 183.380965ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:06:20.337373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.933484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-12T04:06:20.337514Z","caller":"traceutil/trace.go:171","msg":"trace[2018220379] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2157; }","duration":"131.119846ms","start":"2026-09-12T04:06:20.206369Z","end":"2026-09-12T04:06:20.337489Z","steps":["trace[2018220379] 'range keys from in-memory index tree' (duration: 130.776002ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:06:20.778382Z","caller":"traceutil/trace.go:171","msg":"trace[1820281562] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"112.029599ms","start":"2026-09-12T04:06:20.666323Z","end":"2026-09-12T04:06:20.778352Z","steps":["trace[1820281562] 'read index received' (duration: 52.517582ms)","trace[1820281562] 'applied index is now lower than readState.Index' (duration: 59.510087ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:06:20.778586Z","caller":"traceutil/trace.go:171","msg":"trace[297314942] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"167.537888ms","start":"2026-09-12T04:06:20.611012Z","end":"2026-09-12T04:06:20.77855Z","steps":["trace[297314942] 'process raft request' (duration: 107.91155ms)","trace[297314942] 'compare' (duration: 59.122611ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:06:20.778761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.423384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-12T04:06:20.778811Z","caller":"traceutil/trace.go:171","msg":"trace[1091097736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2160; }","duration":"112.535745ms","start":"2026-09-12T04:06:20.66626Z","end":"2026-09-12T04:06:20.778795Z","steps":["trace[1091097736] 'agreement among raft nodes before linearized reading' (duration: 112.321872ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:06:21.098677Z","caller":"traceutil/trace.go:171","msg":"trace[1393967015] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"215.701489ms","start":"2026-09-12T04:06:20.882953Z","end":"2026-09-12T04:06:21.098654Z","steps":["trace[1393967015] 'process raft request' (duration: 215.553878ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:06:21.247718Z","caller":"traceutil/trace.go:171","msg":"trace[921500981] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2245; }","duration":"228.072756ms","start":"2026-09-12T04:06:21.019625Z","end":"2026-09-12T04:06:21.247698Z","steps":["trace[921500981] 'read index received' (duration: 78.955036ms)","trace[921500981] 'applied index is now lower than readState.Index' (duration: 149.11329ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:06:21.247758Z","caller":"traceutil/trace.go:171","msg":"trace[1541471914] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"364.493925ms","start":"2026-09-12T04:06:20.883242Z","end":"2026-09-12T04:06:21.247736Z","steps":["trace[1541471914] 'process raft request' (duration: 344.621309ms)","trace[1541471914] 'compare' (duration: 19.696614ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T04:06:21.247876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:06:20.883234Z","time spent":"364.571625ms","remote":"127.0.0.1:47478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:06:21.248909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.25036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-12T04:06:21.249005Z","caller":"traceutil/trace.go:171","msg":"trace[1989037971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"229.405903ms","start":"2026-09-12T04:06:21.019576Z","end":"2026-09-12T04:06:21.248982Z","steps":["trace[1989037971] 'agreement among raft nodes before linearized reading' (duration: 228.239079ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:07:51.974477Z","caller":"traceutil/trace.go:171","msg":"trace[2012299632] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"109.680501ms","start":"2026-09-12T04:07:51.864761Z","end":"2026-09-12T04:07:51.974441Z","steps":["trace[2012299632] 'process raft request' (duration: 107.019649ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:07:57.569441Z","caller":"traceutil/trace.go:171","msg":"trace[463293275] linearizableReadLoop","detail":"{readStateIndex:2891; appliedIndex:2890; }","duration":"147.667791ms","start":"2026-09-12T04:07:57.421749Z","end":"2026-09-12T04:07:57.569416Z","steps":["trace[463293275] 'read index received' (duration: 147.429519ms)","trace[463293275] 'applied index is now lower than readState.Index' (duration: 237.392µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:07:57.569507Z","caller":"traceutil/trace.go:171","msg":"trace[470947346] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"362.580622ms","start":"2026-09-12T04:07:57.206905Z","end":"2026-09-12T04:07:57.569486Z","steps":["trace[470947346] 'process raft request' (duration: 362.342849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:07:57.569643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T04:07:57.206845Z","time spent":"362.708533ms","remote":"127.0.0.1:47478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T04:07:57.569763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.007105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-12T04:07:57.569915Z","caller":"traceutil/trace.go:171","msg":"trace[1270540654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2786; }","duration":"148.195778ms","start":"2026-09-12T04:07:57.421699Z","end":"2026-09-12T04:07:57.569895Z","steps":["trace[1270540654] 'agreement among raft nodes before linearized reading' (duration: 147.821343ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:07:57.767725Z","caller":"traceutil/trace.go:171","msg":"trace[1043897896] transaction","detail":"{read_only:false; response_revision:2787; number_of_response:1; }","duration":"189.017052ms","start":"2026-09-12T04:07:57.578621Z","end":"2026-09-12T04:07:57.767638Z","steps":["trace[1043897896] 'process raft request' (duration: 167.239613ms)","trace[1043897896] 'compare' (duration: 20.534265ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:12:47.33744Z","caller":"traceutil/trace.go:171","msg":"trace[659989562] linearizableReadLoop","detail":"{readStateIndex:5153; appliedIndex:5152; }","duration":"114.340487ms","start":"2026-09-12T04:12:47.223068Z","end":"2026-09-12T04:12:47.337409Z","steps":["trace[659989562] 'read index received' (duration: 114.197595ms)","trace[659989562] 'applied index is now lower than readState.Index' (duration: 139.992µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:12:47.337461Z","caller":"traceutil/trace.go:171","msg":"trace[1699728054] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"133.528494ms","start":"2026-09-12T04:12:47.203907Z","end":"2026-09-12T04:12:47.337436Z","steps":["trace[1699728054] 'process raft request' (duration: 133.334352ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:47.337664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.565609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-09-12T04:12:47.33769Z","caller":"traceutil/trace.go:171","msg":"trace[354621777] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4961; }","duration":"114.643151ms","start":"2026-09-12T04:12:47.223039Z","end":"2026-09-12T04:12:47.337683Z","steps":["trace[354621777] 'agreement among raft nodes before linearized reading' (duration: 114.479209ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:47.424128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.091974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T04:12:47.424184Z","caller":"traceutil/trace.go:171","msg":"trace[1311902216] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4962; }","duration":"184.189786ms","start":"2026-09-12T04:12:47.239981Z","end":"2026-09-12T04:12:47.424171Z","steps":["trace[1311902216] 'agreement among raft nodes before linearized reading' (duration: 184.105305ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:53.557251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.1542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T04:12:53.557389Z","caller":"traceutil/trace.go:171","msg":"trace[2089120329] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"273.98498ms","start":"2026-09-12T04:12:53.283368Z","end":"2026-09-12T04:12:53.557353Z","steps":["trace[2089120329] 'process raft request' (duration: 167.633908ms)","trace[2089120329] 'compare' (duration: 105.788126ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:12:53.559625Z","caller":"traceutil/trace.go:171","msg":"trace[961456043] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"274.650968ms","start":"2026-09-12T04:12:53.284956Z","end":"2026-09-12T04:12:53.559607Z","steps":["trace[961456043] 'process raft request' (duration: 274.487546ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:53.559737Z","caller":"traceutil/trace.go:171","msg":"trace[1454452423] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5239; }","duration":"183.689529ms","start":"2026-09-12T04:12:53.37603Z","end":"2026-09-12T04:12:53.559719Z","steps":["trace[1454452423] 'read index received' (duration: 74.985289ms)","trace[1454452423] 'applied index is now lower than readState.Index' (duration: 108.70143ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T04:12:53.559854Z","caller":"traceutil/trace.go:171","msg":"trace[1145466954] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"274.753349ms","start":"2026-09-12T04:12:53.285067Z","end":"2026-09-12T04:12:53.559821Z","steps":["trace[1145466954] 'process raft request' (duration: 274.432526ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:53.55963Z","caller":"traceutil/trace.go:171","msg":"trace[1008445472] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"275.033153ms","start":"2026-09-12T04:12:53.284558Z","end":"2026-09-12T04:12:53.559592Z","steps":["trace[1008445472] 'process raft request' (duration: 274.76585ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T04:12:53.560038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.003981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-09-12T04:12:53.560069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.030803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-12T04:12:53.560097Z","caller":"traceutil/trace.go:171","msg":"trace[2045465572] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5049; }","duration":"103.112462ms","start":"2026-09-12T04:12:53.456967Z","end":"2026-09-12T04:12:53.560079Z","steps":["trace[2045465572] 'agreement among raft nodes before linearized reading' (duration: 102.90578ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:53.560107Z","caller":"traceutil/trace.go:171","msg":"trace[1466838681] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5049; }","duration":"184.109513ms","start":"2026-09-12T04:12:53.375987Z","end":"2026-09-12T04:12:53.560096Z","steps":["trace[1466838681] 'agreement among raft nodes before linearized reading' (duration: 183.983792ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:53.723333Z","caller":"traceutil/trace.go:171","msg":"trace[1857838025] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"107.88423ms","start":"2026-09-12T04:12:53.615433Z","end":"2026-09-12T04:12:53.723317Z","steps":["trace[1857838025] 'process raft request' (duration: 98.799712ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:12:56.24621Z","caller":"traceutil/trace.go:171","msg":"trace[1036861273] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"138.743906ms","start":"2026-09-12T04:12:56.107444Z","end":"2026-09-12T04:12:56.246188Z","steps":["trace[1036861273] 'process raft request' (duration: 138.490574ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T04:13:10.653943Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2859} {"level":"info","ts":"2026-09-12T04:13:10.729693Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2859,"took":"74.24188ms","hash":3494381041,"current-db-size-bytes":52604928,"current-db-size":"53 MB","current-db-size-in-use-bytes":27643904,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-12T04:13:10.729762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3494381041,"revision":2859,"compact-revision":-1} {"level":"info","ts":"2026-09-12T04:18:10.662761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5319} {"level":"info","ts":"2026-09-12T04:18:10.746326Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5319,"took":"81.828066ms","hash":1792201063,"current-db-size-bytes":52604928,"current-db-size":"53 MB","current-db-size-in-use-bytes":19013632,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-12T04:18:10.746408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1792201063,"revision":5319,"compact-revision":2859}