Skip to content

PR #1784 #2667

Sign in to view logs

PR #1784

PR #1784 #2667

GitHub Actions / Test Results failed Dec 23, 2024 in 0s

1 errors, 3 fail, 2 329 pass in 14m 57s

2 333 tests  ±0   2 329 ✅ ±0   14m 57s ⏱️ - 6m 10s
  120 suites ±0       0 💤 ±0 
    6 files   ±0       3 ❌  - 1   1 🔥 +1 

Results for commit 517148d. ± Comparison against earlier commit da7bbf3.

Annotations

Check warning on line 0 in github.com/lavanet/lava/v4/protocol/integration

See this annotation in the file changed.

@github-actions github-actions / Test Results

TestConsumerProviderWithProviders (github.com/lavanet/lava/v4/protocol/integration) failed 

artifacts/Test Results (Protocol)/protocol-report.xml [took 11s]
Raw output 
Failed

Check warning on line 0 in github.com/lavanet/lava/v4/protocol/integration

See this annotation in the file changed.

@github-actions github-actions / Test Results

TestConsumerProviderWithProviders/basic-success (github.com/lavanet/lava/v4/protocol/integration) failed 

artifacts/Test Results (Protocol)/protocol-report.xml [took 7s]
Raw output 
Failed
Dec 23 10:24:17 INF setting log level loglevel=debug
Dec 23 10:24:17 DBG batched nodeUrls by services batch="map[|websocket|:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[ws://127.0.0.1:38389, addons: (websocket), internal-path: ]} ||:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[http://127.0.0.1:44793]}]"
Dec 23 10:24:17 INF Finished adding Clients Asynchronously free clients=1 url=http://127.0.0.1:44793
Dec 23 10:24:17 DBG router keys chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000f54ea0 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc000f54c60 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:17 DBG chainRouter created chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000f54ea0 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc000f54c60 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:17 INF Finished adding Clients Asynchronously free clients=1 url="ws://127.0.0.1:38389, addons: (websocket), internal-path: "
badger 2024/12/23 10:24:17 INFO: Set nextTxnTs to 0
Dec 23 10:24:17 DBG Chain Tracker Updated block hashes ApiInterface= ChainID= blocksKept=1 blocksQueried=0 blocksQueueLen=1 latestHash=stubHash-1000 latest_block=1000 nextBlocksUpdate=1100
Dec 23 10:24:17 DBG ChainTracker fetched init data successfully
Dec 23 10:24:17 WRN Warning: Using Self signed certificate is not recommended, this will not allow https connections to be established
Dec 23 10:24:18 INF [++] Provider Listening on Address Address="{Address:localhost:1027 KeyPem: CertPem: DisableTLS:false}" apiInterface=tendermintrpc chainID=LAV1
Dec 23 10:24:18 INF New provider listener active address="{Address:localhost:1027 KeyPem: CertPem: DisableTLS:false}"
Dec 23 10:24:18 INF setting log level loglevel=debug
Dec 23 10:24:18 DBG batched nodeUrls by services batch="map[|websocket|:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[ws://127.0.0.1:42497, addons: (websocket), internal-path: ]} ||:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[http://127.0.0.1:36863]}]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url=http://127.0.0.1:36863
Dec 23 10:24:18 DBG router keys chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000f55e60 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc000f55c20 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 DBG chainRouter created chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000f55e60 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc000f55c20 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url="ws://127.0.0.1:42497, addons: (websocket), internal-path: "
badger 2024/12/23 10:24:18 INFO: Set nextTxnTs to 0
Dec 23 10:24:18 DBG Chain Tracker Updated block hashes ApiInterface= ChainID= blocksKept=1 blocksQueried=0 blocksQueueLen=1 latestHash=stubHash-1000 latest_block=1000 nextBlocksUpdate=1100
Dec 23 10:24:18 DBG ChainTracker fetched init data successfully
Dec 23 10:24:18 WRN Warning: Using Self signed certificate is not recommended, this will not allow https connections to be established
Dec 23 10:24:18 INF [++] Provider Listening on Address Address="{Address:localhost:1028 KeyPem: CertPem: DisableTLS:false}" apiInterface=tendermintrpc chainID=LAV1
Dec 23 10:24:18 INF New provider listener active address="{Address:localhost:1028 KeyPem: CertPem: DisableTLS:false}"
Dec 23 10:24:18 INF setting log level loglevel=debug
Dec 23 10:24:18 DBG batched nodeUrls by services batch="map[|websocket|:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[ws://127.0.0.1:45365, addons: (websocket), internal-path: ]} ||:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[http://127.0.0.1:43937]}]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url=http://127.0.0.1:43937
Dec 23 10:24:18 DBG router keys chainProxyRouter="map[|websocket|:[{ChainProxy:0xc00118bd40 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc00118bb00 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 DBG chainRouter created chainProxyRouter="map[|websocket|:[{ChainProxy:0xc00118bd40 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc00118bb00 addonsSupported:map[:{}] methodsRouted:map[]}]]"
badger 2024/12/23 10:24:18 INFO: Set nextTxnTs to 0
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url="ws://127.0.0.1:45365, addons: (websocket), internal-path: "
Dec 23 10:24:18 DBG Chain Tracker Updated block hashes ApiInterface= ChainID= blocksKept=1 blocksQueried=0 blocksQueueLen=1 latestHash=stubHash-1000 latest_block=1000 nextBlocksUpdate=1100
Dec 23 10:24:18 DBG ChainTracker fetched init data successfully
Dec 23 10:24:18 WRN Warning: Using Self signed certificate is not recommended, this will not allow https connections to be established
Dec 23 10:24:18 INF [++] Provider Listening on Address Address="{Address:localhost:1029 KeyPem: CertPem: DisableTLS:false}" apiInterface=tendermintrpc chainID=LAV1
Dec 23 10:24:18 INF New provider listener active address="{Address:localhost:1029 KeyPem: CertPem: DisableTLS:false}"
Dec 23 10:24:18 INF setting log level loglevel=debug
Dec 23 10:24:18 DBG batched nodeUrls by services batch="map[|websocket|:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[ws://127.0.0.1:39181, addons: (websocket), internal-path: ]} ||:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[http://127.0.0.1:42401]}]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url=http://127.0.0.1:42401
Dec 23 10:24:18 DBG router keys chainProxyRouter="map[|websocket|:[{ChainProxy:0xc0015319e0 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc0015317a0 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url="ws://127.0.0.1:39181, addons: (websocket), internal-path: "
Dec 23 10:24:18 DBG chainRouter created chainProxyRouter="map[|websocket|:[{ChainProxy:0xc0015319e0 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc0015317a0 addonsSupported:map[:{}] methodsRouted:map[]}]]"
badger 2024/12/23 10:24:18 INFO: Set nextTxnTs to 0
Dec 23 10:24:18 DBG Chain Tracker Updated block hashes ApiInterface= ChainID= blocksKept=1 blocksQueried=0 blocksQueueLen=1 latestHash=stubHash-1000 latest_block=1000 nextBlocksUpdate=1100
Dec 23 10:24:18 DBG ChainTracker fetched init data successfully
Dec 23 10:24:18 WRN Warning: Using Self signed certificate is not recommended, this will not allow https connections to be established
Dec 23 10:24:18 INF [++] Provider Listening on Address Address="{Address:localhost:1030 KeyPem: CertPem: DisableTLS:false}" apiInterface=tendermintrpc chainID=LAV1
Dec 23 10:24:18 INF New provider listener active address="{Address:localhost:1030 KeyPem: CertPem: DisableTLS:false}"
Dec 23 10:24:18 INF setting log level loglevel=debug
Dec 23 10:24:18 DBG batched nodeUrls by services batch="map[|websocket|:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[ws://127.0.0.1:45653, addons: (websocket), internal-path: ]} ||:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[http://127.0.0.1:33567]}]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url=http://127.0.0.1:33567
Dec 23 10:24:18 DBG router keys chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000ac7320 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc000ac70e0 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 DBG chainRouter created chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000ac7320 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc000ac70e0 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url="ws://127.0.0.1:45653, addons: (websocket), internal-path: "
badger 2024/12/23 10:24:18 INFO: Set nextTxnTs to 0
Dec 23 10:24:18 DBG Chain Tracker Updated block hashes ApiInterface= ChainID= blocksKept=1 blocksQueried=0 blocksQueueLen=1 latestHash=stubHash-1000 latest_block=1000 nextBlocksUpdate=1100
Dec 23 10:24:18 DBG ChainTracker fetched init data successfully
Dec 23 10:24:18 WRN Warning: Using Self signed certificate is not recommended, this will not allow https connections to be established
Dec 23 10:24:18 INF New provider listener active address="{Address:localhost:1031 KeyPem: CertPem: DisableTLS:false}"
Dec 23 10:24:18 INF [++] Provider Listening on Address Address="{Address:localhost:1031 KeyPem: CertPem: DisableTLS:false}" apiInterface=tendermintrpc chainID=LAV1
Dec 23 10:24:18 INF setting log level loglevel=debug
Dec 23 10:24:18 DBG batched nodeUrls by services batch="map[|websocket|:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[ws://127.0.0.1:34933, addons: (websocket), internal-path: ]} ||:{NetworkAddress:{Address: KeyPem: CertPem: DisableTLS:false} ChainID:LAV1 ApiInterface:tendermintrpc Geolocation:1 NodeUrls:[http://127.0.0.1:41705]}]"
Dec 23 10:24:18 DBG router keys chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000a298c0 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc001098240 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url="ws://127.0.0.1:34933, addons: (websocket), internal-path: "
Dec 23 10:24:18 DBG chainRouter created chainProxyRouter="map[|websocket|:[{ChainProxy:0xc000a298c0 addonsSupported:map[:{}] methodsRouted:map[]}] ||:[{ChainProxy:0xc001098240 addonsSupported:map[:{}] methodsRouted:map[]}]]"
Dec 23 10:24:18 INF Finished adding Clients Asynchronously free clients=1 url=http://127.0.0.1:41705
Dec 23 10:24:18 DBG updated providers epoch=100 spec=LAV1tendermintrpc
Dec 23 10:24:19 INF New relic missing environment file
Dec 23 10:24:19 DBG Sending crafted relays apiInterface=tendermintrpc chainId=LAV1

 ┌───────────────────────────────────────────────────┐ 
 │                   Fiber v2.52.5                   │ 
 │               http://127.0.0.1:1026               │ 
 │                                                   │ 
 │ Handlers ............ 13  Processes ........... 1 │ 
 │ Prefork ....... Disabled  PID ............. 17725 │ 
 └───────────────────────────────────────────────────┘ 

Dec 23 10:24:19 WRN provider data not found, using default address=cosmos1d9m8rnmtrm6yzel2wea7l2hgh0wcpz0rydvzcv
Dec 23 10:24:19 DBG Provider got relay request GUID=6261681768111795853 relay addon= relay extensions= relay_timeout=29.999923333s request.SessionId=2560774801913181554 request.cu=10 request.relayNumber=1 requestBlock=-2 seenBlock=0
Dec 23 10:24:19 DBG provider registered consumer consumer=cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0 epoch=100
Dec 23 10:24:19 DBG Provider creating new sessionID SessionID=2560774801913181554 epoch=100
Dec 23 10:24:19 DBG Before Update Normal PrepareSessionForUsage GUID=6261681768111795853 relayNum=0 relayRequestTotalCU=10 sps.CuSum=10 sps.LatestRelayCu=10 sps.sessionId=2560774801913181554
Dec 23 10:24:19 ERR failed to unmarshal id from response error="invalid character '\x00' looking for beginning of value" id=
Dec 23 10:24:19 ERR tendermintRPC error error="failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value"
Dec 23 10:24:19 ERR Sending chainMsg failed error="tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value" GUID=6261681768111795853 attempt=0 specID=LAV1
Dec 23 10:24:19 ERR TryRelay Failed error="Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value" GUID=6261681768111795853 request.SessionId=2560774801913181554 request.userAddr=cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0 timed_out=false
Dec 23 10:24:19 DBG Provider returned a relay response GUID=6261681768111795853 relay_timeout=29.99863073s request.SessionId=2560774801913181554 request.cu=10 request.relayNumber=1 timeTaken=1.294887ms
Dec 23 10:24:19 DBG could not send relay to provider error="rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}" GUID=6261681768111795853 provider=cosmos1ukaa76ym4ae6mcd29s42g3halmrmg20jf6fnsc
Dec 23 10:24:19 ERR failed relay, insufficient results error="rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}"
Dec 23 10:24:19 ERR [-] failed sending init relay error="failed relay, insufficient results ErrMsg: rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}: rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}" APIInterface=tendermintrpc chainID=LAV1 relayProcessor="relayProcessor {resultsManager {success 0, nodeErrors:0, protocolErrors:1}, unwantedAddresses: ,currentlyUsedAddresses:cosmos1ukaa76ym4ae6mcd29s42g3halmrmg20jf6fnsc}"
Dec 23 10:24:19 DBG Provider got relay request GUID=6261681768111795853 relay addon= relay extensions= relay_timeout=29.999927171s request.SessionId=6534802780331732683 request.cu=10 request.relayNumber=1 requestBlock=-2 seenBlock=0
Dec 23 10:24:19 DBG provider registered consumer consumer=cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0 epoch=100
Dec 23 10:24:19 DBG Provider creating new sessionID SessionID=6534802780331732683 epoch=100
Dec 23 10:24:19 DBG Before Update Normal PrepareSessionForUsage GUID=6261681768111795853 relayNum=0 relayRequestTotalCU=10 sps.CuSum=10 sps.LatestRelayCu=10 sps.sessionId=6534802780331732683
Dec 23 10:24:19 ERR failed to unmarshal id from response error="invalid character '\x00' looking for beginning of value" id=
Dec 23 10:24:19 ERR tendermintRPC error error="failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value"
Dec 23 10:24:19 ERR Sending chainMsg failed error="tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value" GUID=6261681768111795853 attempt=0 specID=LAV1
Dec 23 10:24:19 ERR TryRelay Failed error="Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value" GUID=6261681768111795853 request.SessionId=6534802780331732683 request.userAddr=cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0 timed_out=false
Dec 23 10:24:19 DBG Provider returned a relay response GUID=6261681768111795853 relay_timeout=29.99863026s request.SessionId=6534802780331732683 request.cu=10 request.relayNumber=1 timeTaken=1.299055ms
Dec 23 10:24:19 DBG could not send relay to provider error="rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:6534802780331732683,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}" GUID=6261681768111795853 provider=cosmos1d9m8rnmtrm6yzel2wea7l2hgh0wcpz0rydvzcv
Dec 23 10:24:19 ERR failed relay, insufficient results error="rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}"
Dec 23 10:24:19 ERR [-] failed sending init relay error="failed relay, insufficient results ErrMsg: rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}: rpc error: code = Unknown desc = failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: TryRelay Failed ErrMsg: Sending chainMsg failed ErrMsg: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {attempt:0,GUID:6261681768111795853,specID:LAV1}: tendermintRPC error ErrMsg: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value: failed to unmarshal id from response ErrMsg: invalid character '\x00' looking for beginning of value {id:}: invalid character '\x00' looking for beginning of value {request.SessionId:2560774801913181554,request.userAddr:cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0,GUID:6261681768111795853,timed_out:false}" APIInterface=tendermintrpc chainID=LAV1 relayProcessor="relayProcessor {resultsManager {success 0, nodeErrors:0, protocolErrors:2}, unwantedAddresses: cosmos1ukaa76ym4ae6mcd29s42g3halmrmg20jf6fnsc,currentlyUsedAddresses:cosmos1d9m8rnmtrm6yzel2wea7l2hgh0wcpz0rydvzcv}"
Dec 23 10:24:19 DBG Provider got relay request GUID=6261681768111795853 relay addon= relay extensions= relay_timeout=29.999919885s request.SessionId=9127819174012955531 request.cu=10 request.relayNumber=1 requestBlock=-2 seenBlock=0
Dec 23 10:24:19 DBG provider registered consumer consumer=cosmos195azdjnscw8dxl0ycuv4ge0qz07v6egd39n8l0 epoch=100
Dec 23 10:24:19 DBG Provider creating new sessionID SessionID=9127819174012955531 epoch=100
Dec 23 10:24:19 DBG Before Update Normal PrepareSessionForUsage GUID=6261681768111795853 relayNum=0 relayRequestTotalCU=10 sps.…012955531 request.cu=5000 request.relayNumber=501 timeTaken=3.856112ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980039920159680640 down percent=0.001996007984031936
Dec 23 10:24:24 DBG tendermint http in/out GUID=9891547834545803784 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.180716ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=915325204793406574 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=915325204793406574 relay addon= relay extensions= relay_timeout=29.99991955s request.SessionId=2858175844014309905 request.cu=4790 request.relayNumber=480 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=915325204793406574 relayNum=479 relayRequestTotalCU=4790 sps.CuSum=4790 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=915325204793406574 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=480 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=915325204793406574 relay_timeout=29.996029553s request.SessionId=2858175844014309905 request.cu=4790 request.relayNumber=480 timeTaken=3.892041ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979166666666666670 down percent=0.002083333333333333
Dec 23 10:24:24 DBG tendermint http in/out GUID=915325204793406574 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.196173ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=2939784475660360756 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=2939784475660360756 relay addon= relay extensions= relay_timeout=29.999923277s request.SessionId=9127819174012955531 request.cu=5010 request.relayNumber=502 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=2939784475660360756 relayNum=501 relayRequestTotalCU=5010 sps.CuSum=5010 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=2939784475660360756 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=502 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=2939784475660360756 relay_timeout=29.993137206s request.SessionId=9127819174012955531 request.cu=5010 request.relayNumber=502 timeTaken=6.787694ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980079681274900400 down percent=0.001992031872509960
Dec 23 10:24:24 DBG tendermint http in/out GUID=2939784475660360756 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=8.344432ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=5562141396821720372 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=5562141396821720372 relay addon= relay extensions= relay_timeout=29.999920279s request.SessionId=9127819174012955531 request.cu=5020 request.relayNumber=503 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=5562141396821720372 relayNum=502 relayRequestTotalCU=5020 sps.CuSum=5020 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=5562141396821720372 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=503 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=5562141396821720372 relay_timeout=29.996038042s request.SessionId=9127819174012955531 request.cu=5020 request.relayNumber=503 timeTaken=3.884361ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980119284294234590 down percent=0.001988071570576541
Dec 23 10:24:24 DBG tendermint http in/out GUID=5562141396821720372 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.237166ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=5793448546046789047 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=5793448546046789047 relay addon= relay extensions= relay_timeout=29.999914551s request.SessionId=9127819174012955531 request.cu=5030 request.relayNumber=504 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=5793448546046789047 relayNum=503 relayRequestTotalCU=5030 sps.CuSum=5030 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=5793448546046789047 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=504 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=5793448546046789047 relay_timeout=29.996053009s request.SessionId=9127819174012955531 request.cu=5030 request.relayNumber=504 timeTaken=3.863194ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980158730158730160 down percent=0.001984126984126984
Dec 23 10:24:24 DBG tendermint http in/out GUID=5793448546046789047 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.202405ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=2718866709010687774 _msg=status dappID=DefaultDappID headers="[{Name:Accept-Encoding Value:gzip} {Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=2718866709010687774 relay addon= relay extensions= relay_timeout=29.999930557s request.SessionId=2858175844014309905 request.cu=4800 request.relayNumber=481 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=2718866709010687774 relayNum=480 relayRequestTotalCU=4800 sps.CuSum=4800 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=2718866709010687774 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=481 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=2718866709010687774 relay_timeout=29.996012844s request.SessionId=2858175844014309905 request.cu=4800 request.relayNumber=481 timeTaken=3.919808ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979209979209979210 down percent=0.002079002079002079
Dec 23 10:24:24 DBG tendermint http in/out GUID=2718866709010687774 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.211112ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=5608908811930805106 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=5608908811930805106 relay addon= relay extensions= relay_timeout=29.999924632s request.SessionId=9127819174012955531 request.cu=5040 request.relayNumber=505 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=5608908811930805106 relayNum=504 relayRequestTotalCU=5040 sps.CuSum=5040 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=5608908811930805106 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=505 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=5608908811930805106 relay_timeout=29.986997439s request.SessionId=9127819174012955531 request.cu=5040 request.relayNumber=505 timeTaken=12.930018ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980198019801980200 down percent=0.001980198019801980
Dec 23 10:24:24 DBG tendermint http in/out GUID=5608908811930805106 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=14.565657ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=13035162469220907833 _msg=status dappID=DefaultDappID headers="[{Name:Accept-Encoding Value:gzip} {Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=13035162469220907833 relay addon= relay extensions= relay_timeout=29.999890151s request.SessionId=9127819174012955531 request.cu=5050 request.relayNumber=506 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=13035162469220907833 relayNum=505 relayRequestTotalCU=5050 sps.CuSum=5050 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=13035162469220907833 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=506 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=13035162469220907833 relay_timeout=29.995866219s request.SessionId=9127819174012955531 request.cu=5050 request.relayNumber=506 timeTaken=4.026386ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980237154150197630 down percent=0.001976284584980237
Dec 23 10:24:24 DBG tendermint http in/out GUID=13035162469220907833 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.716067ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=16263678176913840146 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=16263678176913840146 relay addon= relay extensions= relay_timeout=29.999902554s request.SessionId=9127819174012955531 request.cu=5060 request.relayNumber=507 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=16263678176913840146 relayNum=506 relayRequestTotalCU=5060 sps.CuSum=5060 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=16263678176913840146 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=507 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=16263678176913840146 relay_timeout=29.995888206s request.SessionId=9127819174012955531 request.cu=5060 request.relayNumber=507 timeTaken=4.016674ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980276134122287970 down percent=0.001972386587771203
Dec 23 10:24:24 DBG tendermint http in/out GUID=16263678176913840146 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.59509ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=6272018165951901476 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=6272018165951901476 relay addon= relay extensions= relay_timeout=29.999908136s request.SessionId=2858175844014309905 request.cu=4810 request.relayNumber=482 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=6272018165951901476 relayNum=481 relayRequestTotalCU=4810 sps.CuSum=4810 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=6272018165951901476 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=482 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=6272018165951901476 relay_timeout=29.995926022s request.SessionId=2858175844014309905 request.cu=4810 request.relayNumber=482 timeTaken=3.984729ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979253112033195020 down percent=0.002074688796680498
Dec 23 10:24:24 DBG tendermint http in/out GUID=6272018165951901476 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.487895ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=10630521298225134811 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=10630521298225134811 relay addon= relay extensions= relay_timeout=29.999908092s request.SessionId=2858175844014309905 request.cu=4820 request.relayNumber=483 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=10630521298225134811 relayNum=482 relayRequestTotalCU=4820 sps.CuSum=4820 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=10630521298225134811 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=483 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=10630521298225134811 relay_timeout=29.995951821s request.SessionId=2858175844014309905 request.cu=4820 request.relayNumber=483 timeTaken=3.958665ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979296066252587990 down percent=0.002070393374741201
Dec 23 10:24:24 DBG tendermint http in/out GUID=10630521298225134811 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.476945ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=4651221939985643643 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=4651221939985643643 relay addon= relay extensions= relay_timeout=29.999918952s request.SessionId=2858175844014309905 request.cu=4830 request.relayNumber=484 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=4651221939985643643 relayNum=483 relayRequestTotalCU=4830 sps.CuSum=4830 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=4651221939985643643 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=484 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=4651221939985643643 relay_timeout=29.995776608s request.SessionId=2858175844014309905 request.cu=4830 request.relayNumber=484 timeTaken=4.144437ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979338842975206610 down percent=0.002066115702479339
Dec 23 10:24:24 DBG tendermint http in/out GUID=4651221939985643643 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.619811ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=1662068356237866427 _msg=status dappID=DefaultDappID headers="[{Name:Accept-Encoding Value:gzip} {Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=1662068356237866427 relay addon= relay extensions= relay_timeout=29.9999251s request.SessionId=9127819174012955531 request.cu=5070 request.relayNumber=508 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=1662068356237866427 relayNum=507 relayRequestTotalCU=5070 sps.CuSum=5070 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=1662068356237866427 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=508 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=1662068356237866427 relay_timeout=29.995951893s request.SessionId=9127819174012955531 request.cu=5070 request.relayNumber=508 timeTaken=3.976444ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980314960629921260 down percent=0.001968503937007874
Dec 23 10:24:24 DBG tendermint http in/out GUID=1662068356237866427 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.44781ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=11996388950471059306 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=11996388950471059306 relay addon= relay extensions= relay_timeout=29.999911638s request.SessionId=2858175844014309905 request.cu=4840 request.relayNumber=485 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=11996388950471059306 relayNum=484 relayRequestTotalCU=4840 sps.CuSum=4840 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=11996388950471059306 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=485 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=11996388950471059306 relay_timeout=29.995875554s request.SessionId=2858175844014309905 request.cu=4840 request.relayNumber=485 timeTaken=4.038059ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979381443298969070 down percent=0.002061855670103093
Dec 23 10:24:24 DBG tendermint http in/out GUID=11996388950471059306 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.273525ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=17969443919559321350 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=17969443919559321350 relay addon= relay extensions= relay_timeout=29.999935437s request.SessionId=9127819174012955531 request.cu=5080 request.relayNumber=509 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=17969443919559321350 relayNum=508 relayRequestTotalCU=5080 sps.CuSum=5080 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=17969443919559321350 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=509 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=17969443919559321350 relay_timeout=29.996105487s request.SessionId=9127819174012955531 request.cu=5080 request.relayNumber=509 timeTaken=3.831533ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980353634577603140 down percent=0.001964636542239686
Dec 23 10:24:24 DBG tendermint http in/out GUID=17969443919559321350 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=4.958707ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=1573362171230933769 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=1573362171230933769 relay addon= relay extensions= relay_timeout=29.999946411s request.SessionId=2858175844014309905 request.cu=4850 request.relayNumber=486 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=1573362171230933769 relayNum=485 relayRequestTotalCU=4850 sps.CuSum=4850 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=1573362171230933769 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=486 requestedBlock=1000
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 DBG Provider returned a relay response GUID=1573362171230933769 relay_timeout=29.996112977s request.SessionId=2858175844014309905 request.cu=4850 request.relayNumber=486 timeTaken=3.834926ms
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979423868312757200 down percent=0.002057613168724280
Dec 23 10:24:24 DBG tendermint http in/out GUID=1573362171230933769 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=4.99233ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=16269064446141700685 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=16269064446141700685 relay addon= relay extensions= relay_timeout=29.999920494s request.SessionId=9127819174012955531 request.cu=5090 request.relayNumber=510 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=16269064446141700685 relayNum=509 relayRequestTotalCU=5090 sps.CuSum=5090 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=16269064446141700685 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=510 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=16269064446141700685 relay_timeout=29.996058524s request.SessionId=9127819174012955531 request.cu=5090 request.relayNumber=510 timeTaken=3.863663ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980392156862745100 down percent=0.001960784313725490
Dec 23 10:24:24 DBG tendermint http in/out GUID=16269064446141700685 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.073741ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=669792149923187237 _msg=status dappID=DefaultDappID headers="[{Name:Accept-Encoding Value:gzip} {Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=669792149923187237 relay addon= relay extensions= relay_timeout=29.999933058s request.SessionId=2858175844014309905 request.cu=4860 request.relayNumber=487 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=669792149923187237 relayNum=486 relayRequestTotalCU=4860 sps.CuSum=4860 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=669792149923187237 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=487 requestedBlock=1000
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 DBG Provider returned a relay response GUID=669792149923187237 relay_timeout=29.996072837s request.SessionId=2858175844014309905 request.cu=4860 request.relayNumber=487 timeTaken=3.861894ms
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979466119096509240 down percent=0.002053388090349076
Dec 23 10:24:24 DBG tendermint http in/out GUID=669792149923187237 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.151078ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=11963000755278627692 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=11963000755278627692 relay addon= relay extensions= relay_timeout=29.999922896s request.SessionId=2858175844014309905 request.cu=4870 request.relayNumber=488 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=11963000755278627692 relayNum=487 relayRequestTotalCU=4870 sps.CuSum=4870 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=11963000755278627692 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=488 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=11963000755278627692 relay_timeout=29.99611644s request.SessionId=2858175844014309905 request.cu=4870 request.relayNumber=488 timeTaken=3.80818ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979508196721311480 down percent=0.002049180327868852
Dec 23 10:24:24 DBG tendermint http in/out GUID=11963000755278627692 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.090383ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=1255067918236683968 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=1255067918236683968 relay addon= relay extensions= relay_timeout=29.999918302s request.SessionId=2858175844014309905 request.cu=4880 request.relayNumber=489 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=1255067918236683968 relayNum=488 relayRequestTotalCU=4880 sps.CuSum=4880 sps.LatestRelayCu=10 sps.sessionId=2858175844014309905
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=1255067918236683968 method=status replyBlock=1000 request.SessionId=2858175844014309905 request.relayNumber=489 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=1255067918236683968 relay_timeout=29.996062777s request.SessionId=2858175844014309905 request.cu=4880 request.relayNumber=489 timeTaken=3.857158ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.979550102249488750 down percent=0.002044989775051125
Dec 23 10:24:24 DBG tendermint http in/out GUID=1255067918236683968 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 5}" timeTaken=5.105233ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=907210276423904976 _msg=status dappID=DefaultDappID headers="[{Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1} {Name:Accept-Encoding Value:gzip}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=907210276423904976 relay addon= relay extensions= relay_timeout=29.999937549s request.SessionId=9127819174012955531 request.cu=5100 request.relayNumber=511 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=907210276423904976 relayNum=510 relayRequestTotalCU=5100 sps.CuSum=5100 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=907210276423904976 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=511 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=907210276423904976 relay_timeout=29.996029356s request.SessionId=9127819174012955531 request.cu=5100 request.relayNumber=511 timeTaken=3.909737ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980430528375733860 down percent=0.001956947162426614
Dec 23 10:24:24 DBG tendermint http in/out GUID=907210276423904976 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.156041ms
Dec 23 10:24:24 DBG urirpc in <<< GUID=3063034171129377226 _msg=status dappID=DefaultDappID headers="[{Name:Accept-Encoding Value:gzip} {Name:Host Value:localhost:1026} {Name:User-Agent Value:Go-http-client/1.1}]"
Dec 23 10:24:24 DBG Provider got relay request GUID=3063034171129377226 relay addon= relay extensions= relay_timeout=29.999932269s request.SessionId=9127819174012955531 request.cu=5110 request.relayNumber=512 requestBlock=-2 seenBlock=1000
Dec 23 10:24:24 DBG Before Update Normal PrepareSessionForUsage GUID=3063034171129377226 relayNum=511 relayRequestTotalCU=5110 sps.CuSum=5110 sps.LatestRelayCu=10 sps.sessionId=9127819174012955531
Dec 23 10:24:24 DBG Provider Finished Relay Successfully GUID=3063034171129377226 method=status replyBlock=1000 request.SessionId=9127819174012955531 request.relayNumber=512 requestedBlock=1000
Dec 23 10:24:24 DBG Provider returned a relay response GUID=3063034171129377226 relay_timeout=29.996068198s request.SessionId=9127819174012955531 request.cu=5110 request.relayNumber=512 timeTaken=3.865724ms
Dec 23 10:24:24 DBG saving rewards snapshot to the DB proofs=1
Dec 23 10:24:24 INF Saved rewards snapshot to the DB successfully proofs=1
Dec 23 10:24:24 DBG QoS Availability report Availability=0.980468750000000000 down percent=0.001953125000000000
Dec 23 10:24:24 DBG tendermint http in/out GUID=3063034171129377226 HasError=false method=GET path=http://localhost:1026/status request= response="{\"reply\": 3}" timeTaken=5.196721ms
    protocol_test.go:626: 
        	Error Trace:	/home/runner/work/lava/lava/protocol/integration/protocol_test.go:626
        	Error:      	"map[1:1 2:1 3:511 5:488]" should have 5 item(s), but has 4
        	Test:       	TestConsumerProviderWithProviders/basic-success

Check warning on line 0 in github.com/lavanet/lava/v4/protocol/provideroptimizer

See this annotation in the file changed.

@github-actions github-actions / Test Results

TestProviderOptimizerChoiceSimulation (github.com/lavanet/lava/v4/protocol/provideroptimizer) failed 

artifacts/Test Results (Protocol)/protocol-report.xml [took 5s]
Raw output 
Failed
    provider_optimizer_test.go:991: 
        	Error Trace:	/home/runner/work/lava/lava/protocol/provideroptimizer/provider_optimizer_test.go:991
        	Error:      	"0" is not greater than "1000"
        	Test:       	TestProviderOptimizerChoiceSimulation

Check failure on line 0 in github.com/lavanet/lava/v4/testutil/e2e

See this annotation in the file changed.

@github-actions github-actions / Test Results

TestLavaProtocol (github.com/lavanet/lava/v4/testutil/e2e) with error 

artifacts/Test Results (Protocol E2E)/protocol-e2e-report.xml [took 0s]
Raw output 
No test result found
Dec 23 10:23:44 INF Starting Lava
Dec 23 10:23:44 INF Executing Command: ./scripts/start_env_dev.sh
Dec 23 10:23:44 INF Waiting for Lava
Dec 23 10:23:54 INF Waiting for Lava
Dec 23 10:24:04 INF Waiting for Lava
Dec 23 10:24:14 INF Waiting for Lava
Dec 23 10:24:24 INF Waiting for Lava
Dec 23 10:24:34 INF Waiting for Lava
Dec 23 10:24:44 INF Waiting for Lava
Dec 23 10:24:54 INF Waiting for Lava
Dec 23 10:25:04 INF Waiting for Lava
Dec 23 10:25:14 INF Waiting for Lava
Dec 23 10:25:24 INF Waiting for Lava
Dec 23 10:25:34 INF Waiting for Lava
Dec 23 10:25:44 INF Waiting for Lava
Dec 23 10:25:54 INF Waiting for Lava
Dec 23 10:26:04 INF Waiting for Lava
Dec 23 10:26:14 INF Waiting for Lava
Dec 23 10:26:24 INF Waiting for Lava
Dec 23 10:26:34 INF Waiting for Lava
Dec 23 10:26:44 INF Starting Lava OK
Dec 23 10:26:44 INF Staking Lava
Dec 23 10:26:44 INF Executing Command: ./scripts/test/init_e2e.sh
Dec 23 10:27:51 INF stakeLava OK
ETH1
provider lava@1540cy2xwl8zwmx6lle0fsgrfnw5rptavug4pwc [{127.0.0.1:2224 1 [] [jsonrpc] []}]
provider lava@1e809w7tk8psmeacjvz5pmuwg42ft7hu9dr6g46 [{127.0.0.1:2223 1 [] [jsonrpc] []}]
provider lava@1vfmtlgsh8kvecxq8ax2f0v6e6wd0pkls00x09x [{127.0.0.1:2221 1 [debug] [jsonrpc] [archive]}]
provider lava@1w29c0xz8mchlra0s47353z3l5mhhdc6xjzw3vt [{127.0.0.1:2222 1 [] [jsonrpc] []}]
provider lava@1xm8fcgfc6fuv9sv9crm5vj0prhepr6ntll5jm9 [{127.0.0.1:2225 1 [] [jsonrpc] []}]
LAV1
provider lava@12lzjd4x97m9lekj3nlhxm479p8tqq9yet0d390 [{127.0.0.1:2264 1 [] [grpc rest tendermintrpc] []}]
provider lava@15ps9sasmhzn0ktaa3df3p52k8m7sj9jsxnwmyj [{127.0.0.1:2262 1 [] [grpc rest tendermintrpc] []}]
provider lava@1fvzprsw2ty0h5095fht3wqyj7y68pl78upv7e8 [{127.0.0.1:2265 1 [] [grpc rest tendermintrpc] []}]
provider lava@1jm5tt4vxrhfeam2dmxj98mp0v6q4jn4zrz5v72 [{127.0.0.1:2261 1 [] [grpc rest tendermintrpc] []}]
provider lava@1rvdsqt2w3kdczrck8x7a2jxpsfqet6t2nksxkl [{127.0.0.1:2263 1 [] [grpc rest tendermintrpc] []}]
Dec 23 10:27:52 INF Staking Lava OK
Dec 23 10:27:52 INF RUNNING TESTS
Dec 23 10:27:52 INF Executing Command: /opt/hostedtoolcache/go/1.23.4/x64/bin/go test ./testutil/e2e/proxy/. -v -timeout 0 eth
Dec 23 10:27:52 INF startJSONRPCProxy OK
Dec 23 10:27:52 INF Waiting JSONRPC Consumer
Dec 23 10:27:53 INF Waiting JSONRPC Consumer
Dec 23 10:27:54 INF Waiting JSONRPC Consumer
Dec 23 10:27:55 INF Waiting JSONRPC Consumer
Dec 23 10:27:56 INF Waiting JSONRPC Consumer
Dec 23 10:27:57 INF Waiting JSONRPC Consumer
Dec 23 10:27:58 INF Waiting JSONRPC Consumer
Dec 23 10:27:59 INF Waiting JSONRPC Consumer
Dec 23 10:28:00 INF Waiting JSONRPC Consumer
Dec 23 10:28:01 INF Waiting JSONRPC Consumer
Dec 23 10:28:02 INF Waiting JSONRPC Consumer
Dec 23 10:28:03 INF Waiting JSONRPC Consumer
Dec 23 10:28:04 INF Waiting JSONRPC Consumer
Dec 23 10:28:05 INF Waiting JSONRPC Consumer
Dec 23 10:28:06 INF Waiting JSONRPC Consumer
Dec 23 10:28:07 INF Waiting JSONRPC Consumer
Dec 23 10:28:08 INF Waiting JSONRPC Consumer
Dec 23 10:28:09 INF Waiting JSONRPC Consumer
Dec 23 10:28:09 INF JSONRPCProxy OK
Dec 23 10:28:09 INF Validated proxy is alive got response res=16482926
Dec 23 10:28:09 DBG Executing command /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/jsonrpcProvider1.yml --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer1 --geolocation 1 --log_level debug
Dec 23 10:28:09 DBG Executing command /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/jsonrpcProvider2.yml --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer2 --geolocation 1 --log_level debug
Dec 23 10:28:09 DBG Executing command /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/jsonrpcProvider3.yml --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer3 --geolocation 1 --log_level debug
Dec 23 10:28:09 DBG Executing command /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/jsonrpcProvider4.yml --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer4 --geolocation 1 --log_level debug
Dec 23 10:28:09 DBG Executing command /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/jsonrpcProvider5.yml --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer5 --geolocation 1 --log_level debug
Dec 23 10:28:09 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:11 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:13 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:15 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:17 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:19 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:21 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:23 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:25 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:27 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:29 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:31 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:33 INF Waiting Provider 127.0.0.1:2221
Dec 23 10:28:33 INF Waiting Provider 127.0.0.1:2222
Dec 23 10:28:33 INF Waiting Provider 127.0.0.1:2223
Dec 23 10:28:33 INF Waiting Provider 127.0.0.1:2224
Dec 23 10:28:33 INF startJSONRPCProvider OK
Dec 23 10:28:33 INF Executing Command: /home/runner/go/bin/lavap rpcconsumer ./testutil/e2e/e2eConfigs/consumer/ethConsumer1.yml --cache-be 127.0.0.1:2778 --chain-id=lava --from user1 --geolocation 1 --log_level debug --allow-insecure-provider-dialing
Dec 23 10:28:33 INF startJSONRPCConsumer OK
Dec 23 10:28:33 INF Waiting JSONRPC Consumer
Dec 23 10:28:34 INF Waiting JSONRPC Consumer
Dec 23 10:28:35 INF Waiting JSONRPC Consumer
Dec 23 10:28:36 INF Waiting JSONRPC Consumer
Dec 23 10:28:37 INF Waiting JSONRPC Consumer
Dec 23 10:28:38 INF JSONRPCConsumer1 OK
Dec 23 10:28:38 INF Validated proxy is alive got response res=16482926
Dec 23 10:28:38 INF Executing Command: /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/lavaProvider6 --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer6 --geolocation 1 --log_level debug
Dec 23 10:28:38 INF Executing Command: /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/lavaProvider7 --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer7 --geolocation 1 --log_level debug
Dec 23 10:28:38 INF Executing Command: /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/lavaProvider8 --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer8 --geolocation 1 --log_level debug
Dec 23 10:28:38 INF Executing Command: /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/lavaProvider9 --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer9 --geolocation 1 --log_level debug
Dec 23 10:28:38 INF Executing Command: /home/runner/go/bin/lavap rpcprovider ./testutil/e2e/e2eConfigs/provider/lavaProvider10 --cache-be 127.0.0.1:2777 --chain-id=lava --from servicer10 --geolocation 1 --log_level debug
Dec 23 10:28:38 INF Waiting Provider 127.0.0.1:2261
Dec 23 10:28:40 INF Waiting Provider 127.0.0.1:2261
Dec 23 10:28:42 INF Waiting Provider 127.0.0.1:2261
Dec 23 10:28:42 INF Waiting Provider 127.0.0.1:2262
Dec 23 10:28:42 INF Waiting Provider 127.0.0.1:2263
Dec 23 10:28:42 INF Waiting Provider 127.0.0.1:2264
Dec 23 10:28:42 INF Waiting Provider 127.0.0.1:2265
Dec 23 10:28:42 INF startLavaProviders OK
Dec 23 10:28:42 INF Executing Command: /home/runner/go/bin/lavap rpcconsumer ./testutil/e2e/e2eConfigs/consumer/lavaConsumer1.yml --cache-be 127.0.0.1:2778 --chain-id=lava --from user3 --geolocation 1 --log_level debug --allow-insecure-provider-dialing
Dec 23 10:28:42 INF startRPCConsumer OK
Dec 23 10:28:42 INF Waiting TENDERMINT Consumer
Dec 23 10:28:43 INF Waiting TENDERMINT Consumer
Dec 23 10:28:44 INF Waiting TENDERMINT Consumer
Dec 23 10:28:45 INF Waiting TENDERMINT Consumer
Dec 23 10:28:46 INF Waiting TENDERMINT Consumer
Dec 23 10:28:47 INF Waiting TENDERMINT Consumer
Dec 23 10:28:47 INF checkTendermintConsumer OK
Dec 23 10:28:47 INF Waiting REST Consumer
Dec 23 10:28:47 INF checkRESTConsumer OK
Dec 23 10:28:47 INF Waiting GRPC Consumer
Dec 23 10:28:47 INF checkGRPCConsumer OK
Dec 23 10:28:47 INF Starting JSONRPC Tests
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=2742285 fileName=02_jsonProxy lines=2742285
Dec 23 10:29:06 ERR startLavaProviders (provider 03) cmd wait err error="signal: killed"
Dec 23 10:29:06 ERR startRPCConsumer (consumer 01) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=486642 fileName=00_StartLava lines=486642
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=21482 fileName=03_EthProvider_02 lines=21482
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=7565 fileName=03_EthProvider_03 lines=7565
Dec 23 10:29:06 DBG success writing to file bytesWritten=7565 fileName=03_EthProvider_04 lines=7565
Dec 23 10:29:06 DBG success writing to file bytesWritten=15212 fileName=05_LavaProvider_01 lines=15212
Dec 23 10:29:06 DBG success writing to file bytesWritten=18194 fileName=05_LavaProvider_02 lines=18194
Dec 23 10:29:06 DBG success writing to file bytesWritten=18242 fileName=05_LavaProvider_04 lines=18242
Dec 23 10:29:06 DBG success writing to file bytesWritten=33171 fileName=06_RPCConsumer_01 lines=33171
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 ERR startJSONRPCProvider (provider 03) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=27210 fileName=03_EthProvider_01 lines=27210
Dec 23 10:29:06 DBG success writing to file bytesWritten=2742285 fileName=02_jsonProxy lines=2742285
Dec 23 10:29:06 ERR startJSONRPCProvider (provider 05) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=27210 fileName=03_EthProvider_01 lines=27210
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 ERR startLavaProviders (provider 05) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=27210 fileName=03_EthProvider_01 lines=27210
Dec 23 10:29:06 ERR startLavaProviders (provider 02) cmd wait err error="signal: killed"
Dec 23 10:29:06 ERR startJSONRPCProvider (provider 02) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=18242 fileName=05_LavaProvider_04 lines=18242
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=33171 fileName=06_RPCConsumer_01 lines=33171
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=486642 fileName=00_StartLava lines=486642
Dec 23 10:29:06 DBG success writing to file bytesWritten=21482 fileName=03_EthProvider_02 lines=21482
Dec 23 10:29:06 DBG success writing to file bytesWritten=7565 fileName=03_EthProvider_03 lines=7565
Dec 23 10:29:06 DBG success writing to file bytesWritten=7565 fileName=03_EthProvider_04 lines=7565
Dec 23 10:29:06 DBG success writing to file bytesWritten=15212 fileName=05_LavaProvider_01 lines=15212
Dec 23 10:29:06 DBG success writing to file bytesWritten=18194 fileName=05_LavaProvider_02 lines=18194
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 ERR startJSONRPCProvider (provider 04) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=2742285 fileName=02_jsonProxy lines=2742285
Dec 23 10:29:06 ERR startLavaProviders (provider 01) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=83502 fileName=04_jsonConsumer_01 lines=83502
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 ERR startJSONRPCProxy cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=18242 fileName=05_LavaProvider_04 lines=18242
Dec 23 10:29:06 DBG success writing to file bytesWritten=2742285 fileName=02_jsonProxy lines=2742285
Dec 23 10:29:06 ERR startLavaProviders (provider 04) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=19463 fileName=03_EthProvider_05 lines=19463
Dec 23 10:29:06 DBG success writing to file bytesWritten=16353 fileName=05_LavaProvider_03 lines=16353
Dec 23 10:29:06 DBG success writing to file bytesWritten=15404 fileName=05_LavaProvider_05 lines=15404
Dec 23 10:29:06 DBG success writing to file bytesWritten=7565 fileName=03_EthProvider_03 lines=7565
Dec 23 10:29:06 DBG success writing to file bytesWritten=7565 fileName=03_EthProvider_04 lines=7565
Dec 23 10:29:06 DBG success writing to file bytesWritten=15212 fileName=05_LavaProvider_01 lines=15212
Dec 23 10:29:06 DBG success writing to file bytesWritten=18194 fileName=05_LavaProvider_02 lines=18194
Dec 23 10:29:06 DBG success writing to file bytesWritten=18242 fileName=05_LavaProvider_04 lines=18242
Dec 23 10:29:06 DBG success writing to file bytesWritten=33171 fileName=06_RPCConsumer_01 lines=33171
Dec 23 10:29:06 DBG success writing to file bytesWritten=490272 fileName=00_StartLava lines=490272
Dec 23 10:29:06 DBG success writing to file bytesWritten=33171 fileName=06_RPCConsumer_01 lines=33171
Dec 23 10:29:06 ERR startJSONRPCConsumer (consumer 01) cmd wait err error="signal: killed"
Dec 23 10:29:06 DBG success writing to file bytesWritten=8343 fileName=01_stakeLava lines=8343
Dec 23 10:29:06 DBG success writing to file bytesWritten=21482 fileName=03_EthProvider_02 lines=21482
Dec 23 10:29:06 DBG success writing to file bytesWritten=27210 fileName=03_EthProvider_01 lines=27210
ERROR:  Dec 23 10:28:45 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2778
ERROR:  Dec 23 10:28:12 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:36 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2778
Dec 23 10:28:52 ERR failed getting responses from providers error="No pairings available." GUID=2482684117124496971 endpoint=ETH1jsonrpc relayProcessor="relayProcessor {resultsManager {success 0, nodeErrors:0, protocolErrors:0}, unwantedAddresses: ,currentlyUsedAddresses:}" userIp=127.0.0.1
Dec 23 10:28:52 ERR UniqueGuidResponseForError error="No pairings available." msgSeed=2482684117124496971
Dec 23 10:28:52 ERR jsonrpc http error="No pairings available." GUID=2482684117124496971 HasError=true method=POST path=http://127.0.0.1:3331/ request="{\"jsonrpc\":\"2.0\",\"id\":10,\"method\":\"eth_getBlockByNumber\",\"params\":[\"0x0\",true]}" response="{\"Error_GUID\":\"2482684117124496971\",\"Error\":\"No pairings available.\"}" timeTaken=17.585784ms
Dec 23 10:28:57 ERR failed getting responses from providers error="No pairings available." GUID=11802683986143143523 endpoint=ETH1jsonrpc relayProcessor="relayProcessor {resultsManager {success 0, nodeErrors:0, protocolErrors:0}, unwantedAddresses: ,currentlyUsedAddresses:}" userIp=127.0.0.1
ERROR:  Dec 23 10:28:41 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:12 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:12 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:41 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:41 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:12 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:12 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:41 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
ERROR:  Dec 23 10:28:41 ERR Failed To Connect to cache at address error="context deadline exceeded" address=127.0.0.1:2777
panic: Error found in logs on ./testutil/e2e/protocolLogs/04_jsonConsumer_01, 05_LavaProvider_03, 05_LavaProvider_05, 03_EthProvider_05, 03_EthProvider_01, 03_EthProvider_03, 03_EthProvider_04, 05_LavaProvider_01, 05_LavaProvider_02, 05_LavaProvider_04, 06_RPCConsumer_01, 03_EthProvider_02

goroutine 282 [running]:
github.com/lavanet/lava/v4/testutil/e2e.(*lavaTest).saveLogs(0xc000639800)
	/home/runner/work/lava/lava/testutil/e2e/protocolE2E.go:939 +0x8e5
github.com/lavanet/lava/v4/testutil/e2e.(*lavaTest).listenCmdCommand(0xc000639800, 0xc000614620?, {0xc0011badc0, 0x3e}, {0xc000614620, 0x20})
	/home/runner/work/lava/lava/testutil/e2e/protocolE2E.go:175 +0xb1
github.com/lavanet/lava/v4/testutil/e2e.(*lavaTest).execCommand.func2()
	/home/runner/work/lava/lava/testutil/e2e/protocolE2E.go:162 +0x65
created by github.com/lavanet/lava/v4/testutil/e2e.(*lavaTest).execCommand in goroutine 10
	/home/runner/work/lava/lava/testutil/e2e/protocolE2E.go:161 +0x386
View more details on GitHub Actions