{"level":"warn","ts":"2026-05-12T01:43:23.264969Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T01:43:23.265066Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.214.50: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.214.50:2380","--initial-cluster=instance=https://199.19.214.50:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.214.50:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.214.50:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-12T01:43:23.265141Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T01:43:23.265155Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.214.50:2380"]} {"level":"info","ts":"2026-05-12T01:43:23.26518Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-12T01:43:23.265907Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.214.50:2379"]} {"level":"info","ts":"2026-05-12T01:43:23.265982Z","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.214.50:2380"],"listen-peer-urls":["https://199.19.214.50:2380"],"advertise-client-urls":["https://199.19.214.50:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.214.50:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.214.50:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-12T01:43:23.270116Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.852511ms"} {"level":"info","ts":"2026-05-12T01:43:23.283281Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9cdb22f4fbdd66dc","cluster-id":"5e776ba654e06bfe"} {"level":"info","ts":"2026-05-12T01:43:23.283402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T01:43:23.283503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc became follower at term 0"} {"level":"info","ts":"2026-05-12T01:43:23.283531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9cdb22f4fbdd66dc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T01:43:23.283542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc became follower at term 1"} {"level":"info","ts":"2026-05-12T01:43:23.283593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc switched to configuration voters=(11302666125409347292)"} {"level":"warn","ts":"2026-05-12T01:43:23.291926Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T01:43:23.293214Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T01:43:23.294981Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-12T01:43:23.29863Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9cdb22f4fbdd66dc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T01:43:23.298809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9cdb22f4fbdd66dc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T01:43:23.299046Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T01:43:23.299256Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T01:43:23.299279Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T01:43:23.302104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc switched to configuration voters=(11302666125409347292)"} {"level":"info","ts":"2026-05-12T01:43:23.302404Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5e776ba654e06bfe","local-member-id":"9cdb22f4fbdd66dc","added-peer-id":"9cdb22f4fbdd66dc","added-peer-peer-urls":["https://199.19.214.50:2380"]} {"level":"info","ts":"2026-05-12T01:43:23.305477Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-12T01:43:23.305709Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.214.50:2380"} {"level":"info","ts":"2026-05-12T01:43:23.305777Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.214.50:2380"} {"level":"info","ts":"2026-05-12T01:43:23.306048Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9cdb22f4fbdd66dc","initial-advertise-peer-urls":["https://199.19.214.50:2380"],"listen-peer-urls":["https://199.19.214.50:2380"],"advertise-client-urls":["https://199.19.214.50:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.214.50:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T01:43:23.3061Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T01:43:23.584366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T01:43:23.584432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T01:43:23.584473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc received MsgPreVoteResp from 9cdb22f4fbdd66dc at term 1"} {"level":"info","ts":"2026-05-12T01:43:23.584499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc became candidate at term 2"} {"level":"info","ts":"2026-05-12T01:43:23.584516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc received MsgVoteResp from 9cdb22f4fbdd66dc at term 2"} {"level":"info","ts":"2026-05-12T01:43:23.584548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9cdb22f4fbdd66dc became leader at term 2"} {"level":"info","ts":"2026-05-12T01:43:23.584569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9cdb22f4fbdd66dc elected leader 9cdb22f4fbdd66dc at term 2"} {"level":"info","ts":"2026-05-12T01:43:23.586078Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9cdb22f4fbdd66dc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.214.50:2379]}","request-path":"/0/members/9cdb22f4fbdd66dc/attributes","cluster-id":"5e776ba654e06bfe","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T01:43:23.586197Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T01:43:23.586383Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T01:43:23.586436Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T01:43:23.587438Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5e776ba654e06bfe","local-member-id":"9cdb22f4fbdd66dc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T01:43:23.587683Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T01:43:23.5878Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T01:43:23.589826Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T01:43:23.590217Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T01:43:23.590906Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T01:43:23.590839Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.214.50:2379"} {"level":"info","ts":"2026-05-12T01:43:31.747033Z","caller":"traceutil/trace.go:171","msg":"trace[1982471374] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"143.017368ms","start":"2026-05-12T01:43:31.603986Z","end":"2026-05-12T01:43:31.747004Z","steps":["trace[1982471374] 'process raft request' (duration: 140.812143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:38.702579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7411972920620324493,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T01:43:39.098093Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.058711434s","expected-duration":"1s"} {"level":"info","ts":"2026-05-12T01:43:39.098663Z","caller":"traceutil/trace.go:171","msg":"trace[699322255] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"1.059345139s","start":"2026-05-12T01:43:38.039281Z","end":"2026-05-12T01:43:39.098626Z","steps":["trace[699322255] 'process raft request' (duration: 1.059142964s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:39.099589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:38.039263Z","time spent":"1.059514294s","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:43:39.688344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.585155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T01:43:39.688494Z","caller":"traceutil/trace.go:171","msg":"trace[1952005844] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"1.48645745s","start":"2026-05-12T01:43:38.202016Z","end":"2026-05-12T01:43:39.688474Z","steps":["trace[1952005844] 'read index received' (duration: 896.561044ms)","trace[1952005844] 'applied index is now lower than readState.Index' (duration: 589.894845ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:43:39.688587Z","caller":"traceutil/trace.go:171","msg":"trace[1625295506] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"1.107469023s","start":"2026-05-12T01:43:38.581107Z","end":"2026-05-12T01:43:39.688576Z","steps":["trace[1625295506] 'process raft request' (duration: 709.397826ms)","trace[1625295506] 'compare' (duration: 397.472862ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T01:43:39.688647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:38.581082Z","time spent":"1.107529814s","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:43:39.688797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.486735486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T01:43:39.6888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.487412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-05-12T01:43:39.688862Z","caller":"traceutil/trace.go:171","msg":"trace[485146726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"1.4868765s","start":"2026-05-12T01:43:38.201965Z","end":"2026-05-12T01:43:39.688841Z","steps":["trace[485146726] 'agreement among raft nodes before linearized reading' (duration: 1.486717276s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:39.688838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.614616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-12T01:43:39.688862Z","caller":"traceutil/trace.go:171","msg":"trace[1902748383] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:409; }","duration":"399.610275ms","start":"2026-05-12T01:43:39.289235Z","end":"2026-05-12T01:43:39.688845Z","steps":["trace[1902748383] 'agreement among raft nodes before linearized reading' (duration: 399.474031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:39.688908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:38.201945Z","time spent":"1.486951371s","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-12T01:43:39.688919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.289212Z","time spent":"399.696487ms","remote":"127.0.0.1:57326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-12T01:43:39.688923Z","caller":"traceutil/trace.go:171","msg":"trace[2112689225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"248.746999ms","start":"2026-05-12T01:43:39.440152Z","end":"2026-05-12T01:43:39.688899Z","steps":["trace[2112689225] 'agreement among raft nodes before linearized reading' (duration: 248.571015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:39.68891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.460374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-12T01:43:39.688976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323915699s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-05-12T01:43:39.688987Z","caller":"traceutil/trace.go:171","msg":"trace[452363531] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"824.584257ms","start":"2026-05-12T01:43:38.864381Z","end":"2026-05-12T01:43:39.688965Z","steps":["trace[452363531] 'agreement among raft nodes before linearized reading' (duration: 824.456503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:39.689026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:38.864353Z","time spent":"824.665289ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T01:43:39.689039Z","caller":"traceutil/trace.go:171","msg":"trace[849409612] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:409; }","duration":"1.324220297s","start":"2026-05-12T01:43:38.364789Z","end":"2026-05-12T01:43:39.689009Z","steps":["trace[849409612] 'agreement among raft nodes before linearized reading' (duration: 1.323904839s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:39.689111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:38.364767Z","time spent":"1.324333819s","remote":"127.0.0.1:57328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6984,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-05-12T01:43:40.1236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.990552ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:43:40.123711Z","caller":"traceutil/trace.go:171","msg":"trace[1582069352] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:409; }","duration":"186.117875ms","start":"2026-05-12T01:43:39.93758Z","end":"2026-05-12T01:43:40.123697Z","steps":["trace[1582069352] 'range keys from in-memory index tree' (duration: 185.976291ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:40.123713Z","caller":"traceutil/trace.go:171","msg":"trace[253028223] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"429.754527ms","start":"2026-05-12T01:43:39.693936Z","end":"2026-05-12T01:43:40.123691Z","steps":["trace[253028223] 'process raft request' (duration: 379.537904ms)","trace[253028223] 'compare' (duration: 49.851123ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T01:43:40.123814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.693921Z","time spent":"429.81966ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T01:43:40.469469Z","caller":"traceutil/trace.go:171","msg":"trace[1140913455] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"773.707348ms","start":"2026-05-12T01:43:39.695732Z","end":"2026-05-12T01:43:40.469439Z","steps":["trace[1140913455] 'process raft request' (duration: 773.504663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:40.469627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.695722Z","time spent":"773.820701ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T01:43:40.470074Z","caller":"traceutil/trace.go:171","msg":"trace[134424516] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"771.482002ms","start":"2026-05-12T01:43:39.698574Z","end":"2026-05-12T01:43:40.470056Z","steps":["trace[134424516] 'process raft request' (duration: 770.783375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:40.470355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.97679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:43:40.470374Z","caller":"traceutil/trace.go:171","msg":"trace[623045274] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"768.17097ms","start":"2026-05-12T01:43:39.702186Z","end":"2026-05-12T01:43:40.470357Z","steps":["trace[623045274] 'process raft request' (duration: 767.532794ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:40.470413Z","caller":"traceutil/trace.go:171","msg":"trace[1577791266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"773.056122ms","start":"2026-05-12T01:43:39.697343Z","end":"2026-05-12T01:43:40.470399Z","steps":["trace[1577791266] 'agreement among raft nodes before linearized reading' (duration: 772.826626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:40.47046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.702119Z","time spent":"768.295433ms","remote":"127.0.0.1:57326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4360,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:43:40.470493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.697335Z","time spent":"773.138974ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-12T01:43:40.470111Z","caller":"traceutil/trace.go:171","msg":"trace[588092177] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:423; }","duration":"772.723774ms","start":"2026-05-12T01:43:39.697367Z","end":"2026-05-12T01:43:40.47009Z","steps":["trace[588092177] 'read index received' (duration: 376.205602ms)","trace[588092177] 'applied index is now lower than readState.Index' (duration: 396.517012ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T01:43:40.470376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.698564Z","time spent":"771.703368ms","remote":"127.0.0.1:57328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:43:40.470657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.165062ms","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-05-12T01:43:40.470813Z","caller":"traceutil/trace.go:171","msg":"trace[1712934052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"682.360549ms","start":"2026-05-12T01:43:39.788438Z","end":"2026-05-12T01:43:40.470799Z","steps":["trace[1712934052] 'agreement among raft nodes before linearized reading' (duration: 682.184163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:40.470863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:39.788418Z","time spent":"682.43048ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-12T01:43:55.472904Z","caller":"traceutil/trace.go:171","msg":"trace[1194383845] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"155.215373ms","start":"2026-05-12T01:43:55.317663Z","end":"2026-05-12T01:43:55.472879Z","steps":["trace[1194383845] 'process raft request' (duration: 154.64766ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.473133Z","caller":"traceutil/trace.go:171","msg":"trace[460924961] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"148.510386ms","start":"2026-05-12T01:43:55.324615Z","end":"2026-05-12T01:43:55.473126Z","steps":["trace[460924961] 'process raft request' (duration: 148.197979ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.473208Z","caller":"traceutil/trace.go:171","msg":"trace[514834895] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"110.504786ms","start":"2026-05-12T01:43:55.36269Z","end":"2026-05-12T01:43:55.473194Z","steps":["trace[514834895] 'process raft request' (duration: 110.399644ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.47335Z","caller":"traceutil/trace.go:171","msg":"trace[1846665795] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"150.382594ms","start":"2026-05-12T01:43:55.322958Z","end":"2026-05-12T01:43:55.473341Z","steps":["trace[1846665795] 'process raft request' (duration: 149.718858ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.473425Z","caller":"traceutil/trace.go:171","msg":"trace[2016647449] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"139.231588ms","start":"2026-05-12T01:43:55.334185Z","end":"2026-05-12T01:43:55.473416Z","steps":["trace[2016647449] 'process raft request' (duration: 138.702665ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.47353Z","caller":"traceutil/trace.go:171","msg":"trace[590607931] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"117.609091ms","start":"2026-05-12T01:43:55.355914Z","end":"2026-05-12T01:43:55.473523Z","steps":["trace[590607931] 'process raft request' (duration: 117.039947ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.51535Z","caller":"traceutil/trace.go:171","msg":"trace[109039489] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"140.467107ms","start":"2026-05-12T01:43:55.374854Z","end":"2026-05-12T01:43:55.515321Z","steps":["trace[109039489] 'process raft request' (duration: 140.369635ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.515397Z","caller":"traceutil/trace.go:171","msg":"trace[1872481781] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"145.927973ms","start":"2026-05-12T01:43:55.369419Z","end":"2026-05-12T01:43:55.515347Z","steps":["trace[1872481781] 'process raft request' (duration: 145.592075ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:55.515531Z","caller":"traceutil/trace.go:171","msg":"trace[1256837713] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"136.408917ms","start":"2026-05-12T01:43:55.37911Z","end":"2026-05-12T01:43:55.515519Z","steps":["trace[1256837713] 'process raft request' (duration: 136.170951ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:56.406636Z","caller":"traceutil/trace.go:171","msg":"trace[362202298] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"125.300412ms","start":"2026-05-12T01:43:56.281229Z","end":"2026-05-12T01:43:56.406529Z","steps":["trace[362202298] 'process raft request' (duration: 116.627617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.21156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7411972920620324806,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-12T01:43:57.513808Z","caller":"traceutil/trace.go:171","msg":"trace[1161167656] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"813.039394ms","start":"2026-05-12T01:43:56.700741Z","end":"2026-05-12T01:43:57.513781Z","steps":["trace[1161167656] 'process raft request' (duration: 812.628674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.514026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:56.700716Z","time spent":"813.181257ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T01:43:57.552837Z","caller":"traceutil/trace.go:171","msg":"trace[1492132973] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"755.825049ms","start":"2026-05-12T01:43:56.796977Z","end":"2026-05-12T01:43:57.552802Z","steps":["trace[1492132973] 'process raft request' (duration: 755.436419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.553093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:56.796915Z","time spent":"756.101725ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T01:43:57.553099Z","caller":"traceutil/trace.go:171","msg":"trace[85739452] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"718.131105ms","start":"2026-05-12T01:43:56.83494Z","end":"2026-05-12T01:43:57.553071Z","steps":["trace[85739452] 'process raft request' (duration: 717.755376ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:57.553466Z","caller":"traceutil/trace.go:171","msg":"trace[485236940] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"361.280566ms","start":"2026-05-12T01:43:57.192173Z","end":"2026-05-12T01:43:57.553453Z","steps":["trace[485236940] 'process raft request' (duration: 361.079341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.553644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.869333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-05-12T01:43:57.553703Z","caller":"traceutil/trace.go:171","msg":"trace[1739494221] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:612; }","duration":"842.967845ms","start":"2026-05-12T01:43:56.710719Z","end":"2026-05-12T01:43:57.553687Z","steps":["trace[1739494221] 'agreement among raft nodes before linearized reading' (duration: 842.699748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.553765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:56.710706Z","time spent":"843.023616ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29593,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-12T01:43:57.553972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:57.192149Z","time spent":"361.521052ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T01:43:57.553574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:56.834906Z","time spent":"718.570426ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T01:43:57.553342Z","caller":"traceutil/trace.go:171","msg":"trace[2024687296] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"560.72041ms","start":"2026-05-12T01:43:56.99259Z","end":"2026-05-12T01:43:57.55331Z","steps":["trace[2024687296] 'process raft request' (duration: 560.415603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.554289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:56.992568Z","time spent":"561.684014ms","remote":"127.0.0.1:33968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T01:43:57.55334Z","caller":"traceutil/trace.go:171","msg":"trace[400944144] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:626; }","duration":"842.575294ms","start":"2026-05-12T01:43:56.71075Z","end":"2026-05-12T01:43:57.553325Z","steps":["trace[400944144] 'read index received' (duration: 802.641987ms)","trace[400944144] 'applied index is now lower than readState.Index' (duration: 39.932377ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:43:57.553589Z","caller":"traceutil/trace.go:171","msg":"trace[603170126] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"159.996978ms","start":"2026-05-12T01:43:57.393561Z","end":"2026-05-12T01:43:57.553558Z","steps":["trace[603170126] 'process raft request' (duration: 159.730911ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:57.747961Z","caller":"traceutil/trace.go:171","msg":"trace[1699543847] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"193.519407ms","start":"2026-05-12T01:43:57.554372Z","end":"2026-05-12T01:43:57.747891Z","steps":["trace[1699543847] 'read index received' (duration: 139.996903ms)","trace[1699543847] 'applied index is now lower than readState.Index' (duration: 53.521174ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:43:57.747971Z","caller":"traceutil/trace.go:171","msg":"trace[973218891] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"220.925605ms","start":"2026-05-12T01:43:57.526996Z","end":"2026-05-12T01:43:57.747922Z","steps":["trace[973218891] 'process raft request' (duration: 167.360781ms)","trace[973218891] 'compare' (duration: 53.38505ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T01:43:57.748252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.574763ms","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-05-12T01:43:57.748283Z","caller":"traceutil/trace.go:171","msg":"trace[1095110693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"513.681486ms","start":"2026-05-12T01:43:57.234593Z","end":"2026-05-12T01:43:57.748275Z","steps":["trace[1095110693] 'agreement among raft nodes before linearized reading' (duration: 513.474131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.748321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:57.234567Z","time spent":"513.748198ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T01:43:57.748354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.320952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.214.50\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-12T01:43:57.748454Z","caller":"traceutil/trace.go:171","msg":"trace[1620115453] range","detail":"{range_begin:/registry/masterleases/199.19.214.50; range_end:; response_count:1; response_revision:613; }","duration":"879.521987ms","start":"2026-05-12T01:43:56.868913Z","end":"2026-05-12T01:43:57.748435Z","steps":["trace[1620115453] 'agreement among raft nodes before linearized reading' (duration: 879.265641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.748611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:43:56.868886Z","time spent":"879.698682ms","remote":"127.0.0.1:33950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.214.50\" "} {"level":"info","ts":"2026-05-12T01:43:57.790056Z","caller":"traceutil/trace.go:171","msg":"trace[314958138] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"156.482981ms","start":"2026-05-12T01:43:57.633554Z","end":"2026-05-12T01:43:57.790037Z","steps":["trace[314958138] 'process raft request' (duration: 156.44165ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:43:57.790369Z","caller":"traceutil/trace.go:171","msg":"trace[626191205] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"196.713325ms","start":"2026-05-12T01:43:57.593614Z","end":"2026-05-12T01:43:57.790327Z","steps":["trace[626191205] 'process raft request' (duration: 196.290315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:43:57.790643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.625212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-05-12T01:43:57.790793Z","caller":"traceutil/trace.go:171","msg":"trace[964805387] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:615; }","duration":"223.787455ms","start":"2026-05-12T01:43:57.566947Z","end":"2026-05-12T01:43:57.790735Z","steps":["trace[964805387] 'agreement among raft nodes before linearized reading' (duration: 223.397026ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:04.025598Z","caller":"traceutil/trace.go:171","msg":"trace[409163531] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"180.879403ms","start":"2026-05-12T01:44:03.844704Z","end":"2026-05-12T01:44:04.025583Z","steps":["trace[409163531] 'process raft request' (duration: 180.637737ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:04.766667Z","caller":"traceutil/trace.go:171","msg":"trace[214168790] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"253.062991ms","start":"2026-05-12T01:44:04.513577Z","end":"2026-05-12T01:44:04.76664Z","steps":["trace[214168790] 'process raft request' (duration: 252.906837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.766856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.732595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:04.766691Z","caller":"traceutil/trace.go:171","msg":"trace[1912347925] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:706; }","duration":"246.569521ms","start":"2026-05-12T01:44:04.520095Z","end":"2026-05-12T01:44:04.766664Z","steps":["trace[1912347925] 'read index received' (duration: 246.561311ms)","trace[1912347925] 'applied index is now lower than readState.Index' (duration: 6.69µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:44:04.766995Z","caller":"traceutil/trace.go:171","msg":"trace[1168324428] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:684; }","duration":"246.909339ms","start":"2026-05-12T01:44:04.520073Z","end":"2026-05-12T01:44:04.766983Z","steps":["trace[1168324428] 'agreement among raft nodes before linearized reading' (duration: 246.682343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.767185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.845819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T01:44:04.767202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.240375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:04.767265Z","caller":"traceutil/trace.go:171","msg":"trace[279058490] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:684; }","duration":"246.987602ms","start":"2026-05-12T01:44:04.520258Z","end":"2026-05-12T01:44:04.767246Z","steps":["trace[279058490] 'agreement among raft nodes before linearized reading' (duration: 246.806168ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:04.767274Z","caller":"traceutil/trace.go:171","msg":"trace[1730596996] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:684; }","duration":"216.371078ms","start":"2026-05-12T01:44:04.550885Z","end":"2026-05-12T01:44:04.767256Z","steps":["trace[1730596996] 'agreement among raft nodes before linearized reading' (duration: 216.247315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.767418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.077299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:04.767457Z","caller":"traceutil/trace.go:171","msg":"trace[380582317] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:684; }","duration":"231.145991ms","start":"2026-05-12T01:44:04.536299Z","end":"2026-05-12T01:44:04.767445Z","steps":["trace[380582317] 'agreement among raft nodes before linearized reading' (duration: 231.08633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.767564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.642954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-12T01:44:04.767569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.776137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:04.767596Z","caller":"traceutil/trace.go:171","msg":"trace[751234236] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:684; }","duration":"109.693675ms","start":"2026-05-12T01:44:04.657893Z","end":"2026-05-12T01:44:04.767587Z","steps":["trace[751234236] 'agreement among raft nodes before linearized reading' (duration: 109.578622ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:04.767624Z","caller":"traceutil/trace.go:171","msg":"trace[1806195981] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:684; }","duration":"246.859758ms","start":"2026-05-12T01:44:04.520749Z","end":"2026-05-12T01:44:04.767609Z","steps":["trace[1806195981] 'agreement among raft nodes before linearized reading' (duration: 246.756426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.767637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.826019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:04.767668Z","caller":"traceutil/trace.go:171","msg":"trace[280847764] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:684; }","duration":"216.881779ms","start":"2026-05-12T01:44:04.550778Z","end":"2026-05-12T01:44:04.767659Z","steps":["trace[280847764] 'agreement among raft nodes before linearized reading' (duration: 216.810878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.767663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.248873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:04.767704Z","caller":"traceutil/trace.go:171","msg":"trace[1989181915] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:684; }","duration":"216.307024ms","start":"2026-05-12T01:44:04.551387Z","end":"2026-05-12T01:44:04.767694Z","steps":["trace[1989181915] 'agreement among raft nodes before linearized reading' (duration: 216.243233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:04.767821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.533191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T01:44:04.767838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.373297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T01:44:04.767865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.139985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-12T01:44:04.767863Z","caller":"traceutil/trace.go:171","msg":"trace[115899771] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:684; }","duration":"231.596582ms","start":"2026-05-12T01:44:04.536253Z","end":"2026-05-12T01:44:04.767849Z","steps":["trace[115899771] 'agreement among raft nodes before linearized reading' (duration: 231.5307ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:04.767895Z","caller":"traceutil/trace.go:171","msg":"trace[1839161338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:684; }","duration":"114.207447ms","start":"2026-05-12T01:44:04.65368Z","end":"2026-05-12T01:44:04.767888Z","steps":["trace[1839161338] 'agreement among raft nodes before linearized reading' (duration: 114.094574ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:04.767867Z","caller":"traceutil/trace.go:171","msg":"trace[1038337770] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:684; }","duration":"231.404417ms","start":"2026-05-12T01:44:04.536454Z","end":"2026-05-12T01:44:04.767859Z","steps":["trace[1038337770] 'agreement among raft nodes before linearized reading' (duration: 231.360686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:06.038657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.139631ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T01:44:06.038775Z","caller":"traceutil/trace.go:171","msg":"trace[1645517572] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"839.266601ms","start":"2026-05-12T01:44:05.199491Z","end":"2026-05-12T01:44:06.038757Z","steps":["trace[1645517572] 'read index received' (duration: 11.938005ms)","trace[1645517572] 'applied index is now lower than readState.Index' (duration: 827.327386ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:44:06.03898Z","caller":"traceutil/trace.go:171","msg":"trace[944545479] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"1.262843075s","start":"2026-05-12T01:44:04.776107Z","end":"2026-05-12T01:44:06.03895Z","steps":["trace[944545479] 'process raft request' (duration: 435.323244ms)","trace[944545479] 'compare' (duration: 827.001548ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T01:44:06.039013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.512427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:06.039107Z","caller":"traceutil/trace.go:171","msg":"trace[908486819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:686; }","duration":"839.640621ms","start":"2026-05-12T01:44:05.199449Z","end":"2026-05-12T01:44:06.03909Z","steps":["trace[908486819] 'agreement among raft nodes before linearized reading' (duration: 839.474727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:06.039158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:04.776089Z","time spent":"1.262963419s","remote":"127.0.0.1:57398","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-05-12T01:44:06.039169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:05.199429Z","time spent":"839.715912ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-12T01:44:19.916176Z","caller":"traceutil/trace.go:171","msg":"trace[2130448287] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"322.366728ms","start":"2026-05-12T01:44:19.593773Z","end":"2026-05-12T01:44:19.91614Z","steps":["trace[2130448287] 'process raft request' (duration: 322.064291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:19.916553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:19.593746Z","time spent":"322.545953ms","remote":"127.0.0.1:57328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4856,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:44:22.842049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.561928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T01:44:22.842185Z","caller":"traceutil/trace.go:171","msg":"trace[516147264] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"640.059349ms","start":"2026-05-12T01:44:22.202112Z","end":"2026-05-12T01:44:22.842171Z","steps":["trace[516147264] 'read index received' (duration: 350.392158ms)","trace[516147264] 'applied index is now lower than readState.Index' (duration: 289.623389ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:44:22.84222Z","caller":"traceutil/trace.go:171","msg":"trace[1187418873] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"668.000913ms","start":"2026-05-12T01:44:22.17419Z","end":"2026-05-12T01:44:22.842191Z","steps":["trace[1187418873] 'process raft request' (duration: 378.22811ms)","trace[1187418873] 'compare' (duration: 289.467806ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T01:44:22.842262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.154991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:22.842289Z","caller":"traceutil/trace.go:171","msg":"trace[830884210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"640.208052ms","start":"2026-05-12T01:44:22.202073Z","end":"2026-05-12T01:44:22.842281Z","steps":["trace[830884210] 'agreement among raft nodes before linearized reading' (duration: 640.160331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:22.842312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:22.202063Z","time spent":"640.244053ms","remote":"127.0.0.1:33924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-12T01:44:22.842367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:22.174173Z","time spent":"668.113905ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T01:44:23.072125Z","caller":"traceutil/trace.go:171","msg":"trace[2023241180] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:830; }","duration":"229.884104ms","start":"2026-05-12T01:44:22.842212Z","end":"2026-05-12T01:44:23.072097Z","steps":["trace[2023241180] 'read index received' (duration: 197.150531ms)","trace[2023241180] 'applied index is now lower than readState.Index' (duration: 32.732353ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:44:23.072177Z","caller":"traceutil/trace.go:171","msg":"trace[45404387] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"457.646508ms","start":"2026-05-12T01:44:22.614492Z","end":"2026-05-12T01:44:23.072138Z","steps":["trace[45404387] 'process raft request' (duration: 457.393692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:23.072344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:22.614466Z","time spent":"457.793351ms","remote":"127.0.0.1:57368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:44:23.072676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.407332ms","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-05-12T01:44:23.072715Z","caller":"traceutil/trace.go:171","msg":"trace[1928563555] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:805; }","duration":"710.509744ms","start":"2026-05-12T01:44:22.362194Z","end":"2026-05-12T01:44:23.072703Z","steps":["trace[1928563555] 'agreement among raft nodes before linearized reading' (duration: 710.068614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:44:23.07287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:44:22.362168Z","time spent":"710.693489ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-12T01:44:23.072727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.484413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-12T01:44:23.072738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.363421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T01:44:23.072953Z","caller":"traceutil/trace.go:171","msg":"trace[1652251459] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"120.732459ms","start":"2026-05-12T01:44:22.952197Z","end":"2026-05-12T01:44:23.072929Z","steps":["trace[1652251459] 'agreement among raft nodes before linearized reading' (duration: 120.400181ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:44:23.072974Z","caller":"traceutil/trace.go:171","msg":"trace[1553366567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"229.837513ms","start":"2026-05-12T01:44:22.843118Z","end":"2026-05-12T01:44:23.072955Z","steps":["trace[1553366567] 'agreement among raft nodes before linearized reading' (duration: 229.353822ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T01:45:24.823334Z","caller":"traceutil/trace.go:171","msg":"trace[497305453] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"308.456559ms","start":"2026-05-12T01:45:24.514828Z","end":"2026-05-12T01:45:24.823285Z","steps":["trace[497305453] 'read index received' (duration: 308.244314ms)","trace[497305453] 'applied index is now lower than readState.Index' (duration: 210.995µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T01:45:24.823472Z","caller":"traceutil/trace.go:171","msg":"trace[1152682099] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"308.712896ms","start":"2026-05-12T01:45:24.514749Z","end":"2026-05-12T01:45:24.823461Z","steps":["trace[1152682099] 'process raft request' (duration: 308.389928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:45:24.823585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:45:24.514714Z","time spent":"308.790608ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T01:45:24.823716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.877989ms","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:7"} {"level":"info","ts":"2026-05-12T01:45:24.823752Z","caller":"traceutil/trace.go:171","msg":"trace[2068524911] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1137; }","duration":"308.972292ms","start":"2026-05-12T01:45:24.514768Z","end":"2026-05-12T01:45:24.82374Z","steps":["trace[2068524911] 'agreement among raft nodes before linearized reading' (duration: 308.904781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:45:24.823778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:45:24.514744Z","time spent":"309.026853ms","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-12T01:45:24.823743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.21028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T01:45:24.823847Z","caller":"traceutil/trace.go:171","msg":"trace[69747984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1137; }","duration":"300.396364ms","start":"2026-05-12T01:45:24.523426Z","end":"2026-05-12T01:45:24.823822Z","steps":["trace[69747984] 'agreement among raft nodes before linearized reading' (duration: 300.063236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T01:45:24.823899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T01:45:24.523407Z","time spent":"300.482217ms","remote":"127.0.0.1:57398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T01:45:24.82396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.522226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-12T01:45:24.823992Z","caller":"traceutil/trace.go:171","msg":"trace[1817479331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1137; }","duration":"295.583258ms","start":"2026-05-12T01:45:24.528399Z","end":"2026-05-12T01:45:24.823983Z","steps":["trace[1817479331] 'agreement among raft nodes before linearized reading' (duration: 295.454745ms)"],"step_count":1}