{"level":"warn","ts":"2026-08-13T08:50:23.528156Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T08:50:23.52824Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.121:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.121:2380","--initial-cluster=instance=https://199.19.213.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.121: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-08-13T08:50:23.528301Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T08:50:23.528311Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-08-13T08:50:23.528327Z","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-08-13T08:50:23.529449Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"]} {"level":"info","ts":"2026-08-13T08:50:23.529521Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.121: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-08-13T08:50:23.534964Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.267329ms"} {"level":"info","ts":"2026-08-13T08:50:23.545557Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"31541ae44470b70","cluster-id":"8ae2d89c48d1447d"} {"level":"info","ts":"2026-08-13T08:50:23.545682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T08:50:23.54659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 0"} {"level":"info","ts":"2026-08-13T08:50:23.546636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 31541ae44470b70 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T08:50:23.546691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 1"} {"level":"info","ts":"2026-08-13T08:50:23.547745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"warn","ts":"2026-08-13T08:50:23.560577Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T08:50:23.56204Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T08:50:23.563781Z","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-08-13T08:50:23.566077Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"31541ae44470b70","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T08:50:23.566313Z","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-08-13T08:50:23.566359Z","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-08-13T08:50:23.56637Z","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-08-13T08:50:23.566386Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"31541ae44470b70","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T08:50:23.567145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"info","ts":"2026-08-13T08:50:23.567319Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","added-peer-id":"31541ae44470b70","added-peer-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-08-13T08:50:23.572573Z","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-08-13T08:50:23.57303Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-08-13T08:50:23.57314Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-08-13T08:50:23.574447Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"31541ae44470b70","initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T08:50:23.574519Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T08:50:24.048997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T08:50:24.049072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T08:50:24.049095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgPreVoteResp from 31541ae44470b70 at term 1"} {"level":"info","ts":"2026-08-13T08:50:24.049109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became candidate at term 2"} {"level":"info","ts":"2026-08-13T08:50:24.049117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgVoteResp from 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-08-13T08:50:24.049133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became leader at term 2"} {"level":"info","ts":"2026-08-13T08:50:24.049146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 31541ae44470b70 elected leader 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-08-13T08:50:24.051144Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:50:24.051953Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"31541ae44470b70","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.121:2379]}","request-path":"/0/members/31541ae44470b70/attributes","cluster-id":"8ae2d89c48d1447d","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T08:50:24.052023Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:50:24.052204Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:50:24.052319Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:50:24.052098Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:50:24.052499Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:50:24.052611Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T08:50:24.052681Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T08:50:24.054143Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.121:2379"} {"level":"info","ts":"2026-08-13T08:50:24.059696Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T08:50:33.100026Z","caller":"traceutil/trace.go:171","msg":"trace[1335742420] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"246.892823ms","start":"2026-08-13T08:50:32.853095Z","end":"2026-08-13T08:50:33.099988Z","steps":["trace[1335742420] 'read index received' (duration: 246.691439ms)","trace[1335742420] 'applied index is now lower than readState.Index' (duration: 199.734µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:50:33.100104Z","caller":"traceutil/trace.go:171","msg":"trace[1177670611] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"287.013853ms","start":"2026-08-13T08:50:32.81305Z","end":"2026-08-13T08:50:33.100064Z","steps":["trace[1177670611] 'process raft request' (duration: 286.740917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.10033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.118558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-08-13T08:50:33.100379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.2311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-08-13T08:50:33.100544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.407487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-08-13T08:50:33.100544Z","caller":"traceutil/trace.go:171","msg":"trace[1871550714] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:303; }","duration":"247.484257ms","start":"2026-08-13T08:50:32.85303Z","end":"2026-08-13T08:50:33.100515Z","steps":["trace[1871550714] 'agreement among raft nodes before linearized reading' (duration: 247.125248ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.100583Z","caller":"traceutil/trace.go:171","msg":"trace[183788678] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:303; }","duration":"147.484898ms","start":"2026-08-13T08:50:32.95309Z","end":"2026-08-13T08:50:33.100574Z","steps":["trace[183788678] 'agreement among raft nodes before linearized reading' (duration: 147.409458ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.100464Z","caller":"traceutil/trace.go:171","msg":"trace[171987951] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:303; }","duration":"196.299802ms","start":"2026-08-13T08:50:32.904116Z","end":"2026-08-13T08:50:33.100416Z","steps":["trace[171987951] 'agreement among raft nodes before linearized reading' (duration: 196.087517ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.35032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.500295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:50:33.350599Z","caller":"traceutil/trace.go:171","msg":"trace[111207008] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"240.977296ms","start":"2026-08-13T08:50:33.109602Z","end":"2026-08-13T08:50:33.350579Z","steps":["trace[111207008] 'read index received' (duration: 122.739866ms)","trace[111207008] 'applied index is now lower than readState.Index' (duration: 118.23625ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:50:33.350738Z","caller":"traceutil/trace.go:171","msg":"trace[705948297] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"241.042557ms","start":"2026-08-13T08:50:33.109672Z","end":"2026-08-13T08:50:33.350715Z","steps":["trace[705948297] 'process raft request' (duration: 240.859333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.350861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.858493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"warn","ts":"2026-08-13T08:50:33.350786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.170831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-08-13T08:50:33.350902Z","caller":"traceutil/trace.go:171","msg":"trace[1580448868] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:306; }","duration":"239.903154ms","start":"2026-08-13T08:50:33.110988Z","end":"2026-08-13T08:50:33.350891Z","steps":["trace[1580448868] 'agreement among raft nodes before linearized reading' (duration: 239.836372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.350926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.81202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4663"} {"level":"info","ts":"2026-08-13T08:50:33.35102Z","caller":"traceutil/trace.go:171","msg":"trace[834817724] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:306; }","duration":"241.357004ms","start":"2026-08-13T08:50:33.109561Z","end":"2026-08-13T08:50:33.350918Z","steps":["trace[834817724] 'agreement among raft nodes before linearized reading' (duration: 241.141349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.351074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.644758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"warn","ts":"2026-08-13T08:50:33.350862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.804043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"warn","ts":"2026-08-13T08:50:33.351399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.376163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-08-13T08:50:33.351412Z","caller":"traceutil/trace.go:171","msg":"trace[21894564] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:306; }","duration":"240.758641ms","start":"2026-08-13T08:50:33.110379Z","end":"2026-08-13T08:50:33.351138Z","steps":["trace[21894564] 'agreement among raft nodes before linearized reading' (duration: 240.520627ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.351478Z","caller":"traceutil/trace.go:171","msg":"trace[67442486] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:306; }","duration":"240.416704ms","start":"2026-08-13T08:50:33.111009Z","end":"2026-08-13T08:50:33.351425Z","steps":["trace[67442486] 'agreement among raft nodes before linearized reading' (duration: 240.354104ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.351437Z","caller":"traceutil/trace.go:171","msg":"trace[993571550] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:306; }","duration":"241.445615ms","start":"2026-08-13T08:50:33.109977Z","end":"2026-08-13T08:50:33.351423Z","steps":["trace[993571550] 'agreement among raft nodes before linearized reading' (duration: 240.772411ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.351033Z","caller":"traceutil/trace.go:171","msg":"trace[1718807023] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:306; }","duration":"238.950402ms","start":"2026-08-13T08:50:33.112056Z","end":"2026-08-13T08:50:33.351007Z","steps":["trace[1718807023] 'agreement among raft nodes before linearized reading' (duration: 238.699457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.351788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.499021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-08-13T08:50:33.351856Z","caller":"traceutil/trace.go:171","msg":"trace[1577339448] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:306; }","duration":"147.617584ms","start":"2026-08-13T08:50:33.204223Z","end":"2026-08-13T08:50:33.351841Z","steps":["trace[1577339448] 'agreement among raft nodes before linearized reading' (duration: 147.514033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:50:33.352045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.25681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-08-13T08:50:33.352059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.68183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-08-13T08:50:33.3521Z","caller":"traceutil/trace.go:171","msg":"trace[1606900831] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:306; }","duration":"198.349732ms","start":"2026-08-13T08:50:33.153736Z","end":"2026-08-13T08:50:33.352086Z","steps":["trace[1606900831] 'agreement among raft nodes before linearized reading' (duration: 198.222069ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.352113Z","caller":"traceutil/trace.go:171","msg":"trace[413144146] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:306; }","duration":"241.767823ms","start":"2026-08-13T08:50:33.11033Z","end":"2026-08-13T08:50:33.352098Z","steps":["trace[413144146] 'agreement among raft nodes before linearized reading' (duration: 241.554128ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:50:33.35067Z","caller":"traceutil/trace.go:171","msg":"trace[30256995] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"244.987401ms","start":"2026-08-13T08:50:33.105605Z","end":"2026-08-13T08:50:33.350592Z","steps":["trace[30256995] 'process raft request' (duration: 126.653098ms)","trace[30256995] 'compare' (duration: 117.306511ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:50:33.352609Z","caller":"traceutil/trace.go:171","msg":"trace[381275579] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"242.383726ms","start":"2026-08-13T08:50:33.108216Z","end":"2026-08-13T08:50:33.3506Z","steps":["trace[381275579] 'process raft request' (duration: 242.245323ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:04.258965Z","caller":"traceutil/trace.go:171","msg":"trace[934931569] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"177.081143ms","start":"2026-08-13T08:51:04.081861Z","end":"2026-08-13T08:51:04.258942Z","steps":["trace[934931569] 'read index received' (duration: 176.842357ms)","trace[934931569] 'applied index is now lower than readState.Index' (duration: 237.586µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:51:04.259308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.242423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:04.259354Z","caller":"traceutil/trace.go:171","msg":"trace[965989325] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:571; }","duration":"136.318694ms","start":"2026-08-13T08:51:04.123025Z","end":"2026-08-13T08:51:04.259343Z","steps":["trace[965989325] 'agreement among raft nodes before linearized reading' (duration: 136.230352ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:04.259326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.37408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:51:04.259331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.413321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:04.259434Z","caller":"traceutil/trace.go:171","msg":"trace[106193893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"177.529934ms","start":"2026-08-13T08:51:04.081875Z","end":"2026-08-13T08:51:04.259405Z","steps":["trace[106193893] 'agreement among raft nodes before linearized reading' (duration: 177.340209ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:04.259456Z","caller":"traceutil/trace.go:171","msg":"trace[115789205] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"177.586785ms","start":"2026-08-13T08:51:04.081839Z","end":"2026-08-13T08:51:04.259426Z","steps":["trace[115789205] 'agreement among raft nodes before linearized reading' (duration: 177.328009ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:04.259496Z","caller":"traceutil/trace.go:171","msg":"trace[2023197983] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"177.615586ms","start":"2026-08-13T08:51:04.081838Z","end":"2026-08-13T08:51:04.259453Z","steps":["trace[2023197983] 'process raft request' (duration: 176.9501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:04.259557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.790083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:04.259589Z","caller":"traceutil/trace.go:171","msg":"trace[951466546] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:571; }","duration":"135.844154ms","start":"2026-08-13T08:51:04.123736Z","end":"2026-08-13T08:51:04.25958Z","steps":["trace[951466546] 'agreement among raft nodes before linearized reading' (duration: 135.788962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:04.259754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.086453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:04.259789Z","caller":"traceutil/trace.go:171","msg":"trace[261706975] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"165.128823ms","start":"2026-08-13T08:51:04.09465Z","end":"2026-08-13T08:51:04.259779Z","steps":["trace[261706975] 'agreement among raft nodes before linearized reading' (duration: 165.079122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:04.259866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.314527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:04.259902Z","caller":"traceutil/trace.go:171","msg":"trace[1104921851] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"165.353308ms","start":"2026-08-13T08:51:04.094539Z","end":"2026-08-13T08:51:04.259892Z","steps":["trace[1104921851] 'agreement among raft nodes before linearized reading' (duration: 165.295307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:04.259923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.832866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:51:04.259935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.248576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:04.259961Z","caller":"traceutil/trace.go:171","msg":"trace[854096278] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:571; }","duration":"136.895467ms","start":"2026-08-13T08:51:04.123054Z","end":"2026-08-13T08:51:04.25995Z","steps":["trace[854096278] 'agreement among raft nodes before linearized reading' (duration: 136.828715ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:04.259967Z","caller":"traceutil/trace.go:171","msg":"trace[1466692131] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:571; }","duration":"165.286907ms","start":"2026-08-13T08:51:04.09467Z","end":"2026-08-13T08:51:04.259957Z","steps":["trace[1466692131] 'agreement among raft nodes before linearized reading' (duration: 165.240596ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:07.340699Z","caller":"traceutil/trace.go:171","msg":"trace[1046846904] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"180.404087ms","start":"2026-08-13T08:51:07.160262Z","end":"2026-08-13T08:51:07.340667Z","steps":["trace[1046846904] 'process raft request' (duration: 176.312093ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:07.971526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.51477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:51:07.971654Z","caller":"traceutil/trace.go:171","msg":"trace[816557314] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"234.330417ms","start":"2026-08-13T08:51:07.737303Z","end":"2026-08-13T08:51:07.971633Z","steps":["trace[816557314] 'read index received' (duration: 58.25392ms)","trace[816557314] 'applied index is now lower than readState.Index' (duration: 176.074937ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:51:07.971868Z","caller":"traceutil/trace.go:171","msg":"trace[1241598848] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"527.846483ms","start":"2026-08-13T08:51:07.443976Z","end":"2026-08-13T08:51:07.971822Z","steps":["trace[1241598848] 'process raft request' (duration: 349.860322ms)","trace[1241598848] 'compare' (duration: 177.356197ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:51:07.972338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.997522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:51:07.97247Z","caller":"traceutil/trace.go:171","msg":"trace[568725151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"235.156936ms","start":"2026-08-13T08:51:07.737259Z","end":"2026-08-13T08:51:07.972416Z","steps":["trace[568725151] 'agreement among raft nodes before linearized reading' (duration: 234.667334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:07.972001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:51:07.443952Z","time spent":"527.989707ms","remote":"127.0.0.1:33762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:51:07.97265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.940967ms","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-08-13T08:51:07.972768Z","caller":"traceutil/trace.go:171","msg":"trace[1200983172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"147.138942ms","start":"2026-08-13T08:51:07.825603Z","end":"2026-08-13T08:51:07.972742Z","steps":["trace[1200983172] 'agreement among raft nodes before linearized reading' (duration: 146.767134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:51:07.973189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.736997ms","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-08-13T08:51:07.973414Z","caller":"traceutil/trace.go:171","msg":"trace[1979678181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:596; }","duration":"111.021164ms","start":"2026-08-13T08:51:07.862367Z","end":"2026-08-13T08:51:07.973389Z","steps":["trace[1979678181] 'agreement among raft nodes before linearized reading' (duration: 110.011361ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:09.3821Z","caller":"traceutil/trace.go:171","msg":"trace[1505291485] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"123.34458ms","start":"2026-08-13T08:51:09.258721Z","end":"2026-08-13T08:51:09.382066Z","steps":["trace[1505291485] 'process raft request' (duration: 123.064823ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:51:09.393889Z","caller":"traceutil/trace.go:171","msg":"trace[1433191448] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"134.31082ms","start":"2026-08-13T08:51:09.259555Z","end":"2026-08-13T08:51:09.393866Z","steps":["trace[1433191448] 'process raft request' (duration: 134.185237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:40.953176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.932976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:52:40.953384Z","caller":"traceutil/trace.go:171","msg":"trace[400023498] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1906; }","duration":"312.890086ms","start":"2026-08-13T08:52:40.640477Z","end":"2026-08-13T08:52:40.953367Z","steps":["trace[400023498] 'read index received' (duration: 21.503499ms)","trace[400023498] 'applied index is now lower than readState.Index' (duration: 291.385657ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:52:40.953442Z","caller":"traceutil/trace.go:171","msg":"trace[1252365439] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"393.471676ms","start":"2026-08-13T08:52:40.559908Z","end":"2026-08-13T08:52:40.953379Z","steps":["trace[1252365439] 'process raft request' (duration: 102.058229ms)","trace[1252365439] 'compare' (duration: 290.333032ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:52:40.953693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:40.559897Z","time spent":"393.677101ms","remote":"127.0.0.1:33698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:52:40.953774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.109779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:52:40.95385Z","caller":"traceutil/trace.go:171","msg":"trace[1162513678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1835; }","duration":"219.240922ms","start":"2026-08-13T08:52:40.734592Z","end":"2026-08-13T08:52:40.953833Z","steps":["trace[1162513678] 'agreement among raft nodes before linearized reading' (duration: 219.103508ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:52:40.953507Z","caller":"traceutil/trace.go:171","msg":"trace[1712624540] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"333.488465ms","start":"2026-08-13T08:52:40.620002Z","end":"2026-08-13T08:52:40.953491Z","steps":["trace[1712624540] 'process raft request' (duration: 333.29553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:40.954061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:40.619978Z","time spent":"334.019569ms","remote":"127.0.0.1:33698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:52:40.954235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.701873ms","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-08-13T08:52:40.954295Z","caller":"traceutil/trace.go:171","msg":"trace[330453253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1835; }","duration":"183.812595ms","start":"2026-08-13T08:52:40.770468Z","end":"2026-08-13T08:52:40.954281Z","steps":["trace[330453253] 'agreement among raft nodes before linearized reading' (duration: 183.636511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:40.953655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.221284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b5145fb-466e-4ffd-9c16-b1ff92a1d937\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T08:52:40.955481Z","caller":"traceutil/trace.go:171","msg":"trace[2028459084] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b5145fb-466e-4ffd-9c16-b1ff92a1d937; range_end:; response_count:1; response_revision:1835; }","duration":"315.071728ms","start":"2026-08-13T08:52:40.640391Z","end":"2026-08-13T08:52:40.955463Z","steps":["trace[2028459084] 'agreement among raft nodes before linearized reading' (duration: 313.144852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:52:40.955624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:52:40.640378Z","time spent":"315.228744ms","remote":"127.0.0.1:33614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b5145fb-466e-4ffd-9c16-b1ff92a1d937\" "} {"level":"info","ts":"2026-08-13T08:53:15.915694Z","caller":"traceutil/trace.go:171","msg":"trace[1475234601] linearizableReadLoop","detail":"{readStateIndex:2165; appliedIndex:2164; }","duration":"178.548353ms","start":"2026-08-13T08:53:15.737118Z","end":"2026-08-13T08:53:15.915666Z","steps":["trace[1475234601] 'read index received' (duration: 178.285236ms)","trace[1475234601] 'applied index is now lower than readState.Index' (duration: 262.007µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:53:15.915721Z","caller":"traceutil/trace.go:171","msg":"trace[1507721019] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"203.222135ms","start":"2026-08-13T08:53:15.712472Z","end":"2026-08-13T08:53:15.915694Z","steps":["trace[1507721019] 'process raft request' (duration: 203.024891ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:53:15.915875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.743989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:53:15.915919Z","caller":"traceutil/trace.go:171","msg":"trace[1590215183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2085; }","duration":"178.857421ms","start":"2026-08-13T08:53:15.73705Z","end":"2026-08-13T08:53:15.915908Z","steps":["trace[1590215183] 'agreement among raft nodes before linearized reading' (duration: 178.738248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:53:17.507922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.622668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:53:17.508065Z","caller":"traceutil/trace.go:171","msg":"trace[976689399] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2174; }","duration":"236.284873ms","start":"2026-08-13T08:53:17.271757Z","end":"2026-08-13T08:53:17.508042Z","steps":["trace[976689399] 'read index received' (duration: 77.399258ms)","trace[976689399] 'applied index is now lower than readState.Index' (duration: 158.884005ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:53:17.508491Z","caller":"traceutil/trace.go:171","msg":"trace[307828974] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"242.683679ms","start":"2026-08-13T08:53:17.265779Z","end":"2026-08-13T08:53:17.508463Z","steps":["trace[307828974] 'process raft request' (duration: 83.388934ms)","trace[307828974] 'compare' (duration: 158.417443ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:53:17.508647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.860796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-13T08:53:17.508674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.018616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-13T08:53:17.508736Z","caller":"traceutil/trace.go:171","msg":"trace[1102367194] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2094; }","duration":"237.00702ms","start":"2026-08-13T08:53:17.271711Z","end":"2026-08-13T08:53:17.508718Z","steps":["trace[1102367194] 'agreement among raft nodes before linearized reading' (duration: 236.708623ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:53:17.508741Z","caller":"traceutil/trace.go:171","msg":"trace[1770998805] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"179.166219ms","start":"2026-08-13T08:53:17.329559Z","end":"2026-08-13T08:53:17.508725Z","steps":["trace[1770998805] 'agreement among raft nodes before linearized reading' (duration: 178.957534ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:55:05.2997Z","caller":"traceutil/trace.go:171","msg":"trace[1022418349] linearizableReadLoop","detail":"{readStateIndex:2867; appliedIndex:2866; }","duration":"170.187225ms","start":"2026-08-13T08:55:05.12949Z","end":"2026-08-13T08:55:05.299677Z","steps":["trace[1022418349] 'read index received' (duration: 169.945969ms)","trace[1022418349] 'applied index is now lower than readState.Index' (duration: 240.396µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:55:05.299934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.434022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-08-13T08:55:05.299977Z","caller":"traceutil/trace.go:171","msg":"trace[1698804480] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2762; }","duration":"170.538335ms","start":"2026-08-13T08:55:05.129427Z","end":"2026-08-13T08:55:05.299966Z","steps":["trace[1698804480] 'agreement among raft nodes before linearized reading' (duration: 170.35066ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:55:05.300284Z","caller":"traceutil/trace.go:171","msg":"trace[1190621459] transaction","detail":"{read_only:false; response_revision:2762; number_of_response:1; }","duration":"200.837735ms","start":"2026-08-13T08:55:05.099434Z","end":"2026-08-13T08:55:05.300272Z","steps":["trace[1190621459] 'process raft request' (duration: 200.054654ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:55:05.312921Z","caller":"traceutil/trace.go:171","msg":"trace[1345389850] transaction","detail":"{read_only:false; response_revision:2763; number_of_response:1; }","duration":"122.125439ms","start":"2026-08-13T08:55:05.190775Z","end":"2026-08-13T08:55:05.312901Z","steps":["trace[1345389850] 'process raft request' (duration: 121.883742ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:55:37.733255Z","caller":"traceutil/trace.go:171","msg":"trace[1677836852] transaction","detail":"{read_only:false; response_revision:2942; number_of_response:1; }","duration":"184.308929ms","start":"2026-08-13T08:55:37.54891Z","end":"2026-08-13T08:55:37.733219Z","steps":["trace[1677836852] 'process raft request' (duration: 184.112414ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:59:32.389241Z","caller":"traceutil/trace.go:171","msg":"trace[2096116422] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"172.865949ms","start":"2026-08-13T08:59:32.216346Z","end":"2026-08-13T08:59:32.389212Z","steps":["trace[2096116422] 'process raft request' (duration: 172.667445ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:59:32.463712Z","caller":"traceutil/trace.go:171","msg":"trace[1034856022] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"117.507407ms","start":"2026-08-13T08:59:32.346183Z","end":"2026-08-13T08:59:32.46369Z","steps":["trace[1034856022] 'process raft request' (duration: 116.81908ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:59:32.46389Z","caller":"traceutil/trace.go:171","msg":"trace[1170612912] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"117.642189ms","start":"2026-08-13T08:59:32.346238Z","end":"2026-08-13T08:59:32.463881Z","steps":["trace[1170612912] 'process raft request' (duration: 117.073376ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T09:00:24.179556Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-08-13T09:00:24.293073Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"111.746084ms","hash":1081552888,"current-db-size-bytes":54034432,"current-db-size":"54 MB","current-db-size-in-use-bytes":28643328,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-13T09:00:24.293162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1081552888,"revision":2871,"compact-revision":-1} {"level":"info","ts":"2026-08-13T09:05:24.186234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5474} {"level":"info","ts":"2026-08-13T09:05:24.261221Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5474,"took":"73.016386ms","hash":16002322,"current-db-size-bytes":54034432,"current-db-size":"54 MB","current-db-size-in-use-bytes":18722816,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-13T09:05:24.261289Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":16002322,"revision":5474,"compact-revision":2871}