interledger-deprecated/five-bells-demo

Demo transfers failing

Opened this issue · 0 comments

Hi,
I used manual without any changes, but when I try to run transfers, some of them failing with following output:

visualization:5000 2017-04-06T04:32:22.614Z koa INFO   <-- PUT /payments
visualization:5000   ilp-plugin-bells:plugin connecting to account http://localhost:3005/accounts/alice +14s
ledger:3005 2017-04-06T04:32:22.618Z ledger:koa info <-- GET /accounts/alice
ledger:3005 2017-04-06T04:32:22.619Z ledger:accounts debug fetching account name alice
visualization:5000   ilp-plugin-bells:plugin request ledger metadata http://localhost:3005 +7ms
ledger:3005 2017-04-06T04:32:22.623Z ledger:koa info --> GET /accounts/alice 200 5ms 93B
ledger:3005 2017-04-06T04:32:22.624Z ledger:koa info <-- GET /
ledger:3005 2017-04-06T04:32:22.625Z ledger:koa info --> GET / 200 1ms 836B
visualization:5000   ilp-plugin-bells:ledger-context using service urls: { transfer: 'http://localhost:3005/transfers/:id',
visualization:5000   transfer_fulfillment: 'http://localhost:3005/transfers/:id/fulfillment',
visualization:5000   transfer_rejection: 'http://localhost:3005/transfers/:id/rejection',
visualization:5000   account: 'http://localhost:3005/accounts/:name',
visualization:5000   auth_token: 'http://localhost:3005/auth_token',
visualization:5000   websocket: 'ws://localhost:3005/websocket',
visualization:5000   message: 'http://localhost:3005/messages' } +3ms
ledger:3005 2017-04-06T04:32:22.626Z ledger:koa info <-- GET /auth_token
ledger:3005 2017-04-06T04:32:22.632Z ledger:koa info --> GET /auth_token 200 6ms 240B
ledger:3005 2017-04-06T04:32:22.635Z ledger:koa-websocket debug Connection received
visualization:5000   ilp-plugin-bells:plugin ws connected to ws://localhost:3005/websocket?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJpYXQiOjE0OTE0NTMxNDIsImV4cCI6MTQ5MjA1Nzk0MiwiaXNzIjoiaHR0cDovL2xvY2FsaG9zdDozMDA1Iiwic3ViIjoiaHR0cDovL2xvY2FsaG9zdDozMDA1L2FjY291bnRzL2FsaWNlIn0.OOxCsNah9Ayjq-Txr_G-QnSA4O3QAWec4Ma_yP46S_c +10ms
ledger:3005 2017-04-06T04:32:22.636Z ledger:koa info <-| GET /websocket?token=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJpYXQiOjE0OTE0NTMxNDIsImV4cCI6MTQ5MjA1Nzk0MiwiaXNzIjoiaHR0cDovL2xvY2FsaG9zdDozMDA1Iiwic3ViIjoiaHR0cDovL2xvY2FsaG9zdDozMDA1L2FjY291bnRzL2FsaWNlIn0.OOxCsNah9Ayjq-Txr_G-QnSA4O3QAWec4Ma_yP46S_c
ledger:3005 2017-04-06T04:32:22.644Z ledger:rpcHandler info new ws subscriber for alice:*
visualization:5000   ilp-core remote quote connector=demo.ledger5.mark query={"source_address":"demo.ledger5.alice","destination_address":"demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7","destination_amount":"1"} +10ms
visualization:5000   ilp-core remote quote connector=demo.ledger5.mary query={"source_address":"demo.ledger5.alice","destination_address":"demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7","destination_amount":"1"} +0ms
ledger:3005 2017-04-06T04:32:22.647Z ledger:koa info <-- POST /messages
ledger:3005 2017-04-06T04:32:22.648Z ledger:koa info <-- POST /messages
ledger:3005 2017-04-06T04:32:22.654Z ledger:messages debug alice -> mary: { method: 'quote_request', data: { source_address: 'demo.ledger5.alice', destination_address: 'demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7', destination_amount: '1' }, id: '6670bafc-d888-4736-ba03-71cdaeddaab1' }
ledger:3005 2017-04-06T04:32:22.654Z ledger:notificationBroadcaster debug emitting notification:{mary,*}:message.send
ledger:3005 2017-04-06T04:32:22.655Z ledger:koa info --> POST /messages 201 7ms 351B
ledger:3005 2017-04-06T04:32:22.657Z ledger:messages debug alice -> mark: { method: 'quote_request', data: { source_address: 'demo.ledger5.alice', destination_address: 'demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7', destination_amount: '1' }, id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9' }
ledger:3005 2017-04-06T04:32:22.657Z ledger:notificationBroadcaster debug emitting notification:{mark,*}:message.send
ledger:3005 2017-04-06T04:32:22.657Z ledger:koa info --> POST /messages 201 10ms 351B
mary 2017-04-06T04:32:22.659Z ilp-plugin-bells:translate debug notify message http://localhost:3005/accounts/alice
mary message { ledger: 'http://localhost:3005',
mary   from: 'http://localhost:3005/accounts/alice',
mary   to: 'http://localhost:3005/accounts/mary',
mary   data: 
mary    { method: 'quote_request',
mary      data: 
mary       { source_address: 'demo.ledger5.alice',
mary         destination_address: 'demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7',
mary         destination_amount: '1' },
mary      id: '6670bafc-d888-4736-ba03-71cdaeddaab1' },
mary   account: 'http://localhost:3005/accounts/alice' }
mary 2017-04-06T04:32:22.660Z connector:route-builder info creating quote sourceAddress=demo.ledger5.alice sourceAmount=undefined destinationAddress=demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7 destinationAmount=1 destinationPrecisionAndScale=undefined slippage=undefined
mary 2017-04-06T04:32:22.660Z ilp-routing:routing-tables debug searching best hop from demo.ledger5.alice to demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7 for 1 (by dst amount)
mary 2017-04-06T04:32:22.660Z ilp-routing:routing-table debug destination demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7 is not in known destinations: demo.ledger1.,demo.ledger2.
mark 2017-04-06T04:32:22.660Z ilp-plugin-bells:translate debug notify message http://localhost:3005/accounts/alice
mark message { ledger: 'http://localhost:3005',
mark   from: 'http://localhost:3005/accounts/alice',
mark   to: 'http://localhost:3005/accounts/mark',
mark   data: 
mark    { method: 'quote_request',
mark      data: 
mark       { source_address: 'demo.ledger5.alice',
mark         destination_address: 'demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7',
mark         destination_amount: '1' },
mark      id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9' },
mark   account: 'http://localhost:3005/accounts/alice' }
mark 2017-04-06T04:32:22.661Z connector:route-builder info creating quote sourceAddress=demo.ledger5.alice sourceAmount=undefined destinationAddress=demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7 destinationAmount=1 destinationPrecisionAndScale=undefined slippage=undefined
ledger:3005 2017-04-06T04:32:22.662Z ledger:koa info <-- POST /messages
mark 2017-04-06T04:32:22.662Z ilp-routing:routing-tables debug searching best hop from demo.ledger5.alice to demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7 for 1 (by dst amount)
mark 2017-04-06T04:32:22.666Z ilp-routing:routing-table debug destination demo.ledger6.bob.9481ddda-e3da-41c7-a457-0a2a269079f7 is not in known destinations: demo.ledger3.
ledger:3005 2017-04-06T04:32:22.668Z ledger:messages debug mary -> alice: { id: '6670bafc-d888-4736-ba03-71cdaeddaab1', method: 'error', data: { id: 'AssetsNotTradedError', message: 'This connector does not support the given asset pair' } }
ledger:3005 2017-04-06T04:32:22.668Z ledger:notificationBroadcaster debug emitting notification:{alice,*}:message.send
ledger:3005 2017-04-06T04:32:22.670Z ledger:koa info --> POST /messages 201 8ms 295B
ledger:3005 2017-04-06T04:32:22.671Z ledger:koa info <-- POST /messages
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mary +28ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mary',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '6670bafc-d888-4736-ba03-71cdaeddaab1',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mary' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mary +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mary',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '6670bafc-d888-4736-ba03-71cdaeddaab1',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mary' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mary +1ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mary',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '6670bafc-d888-4736-ba03-71cdaeddaab1',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mary' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mary +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mary',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '6670bafc-d888-4736-ba03-71cdaeddaab1',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mary' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mary +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mary',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '6670bafc-d888-4736-ba03-71cdaeddaab1',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mary' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mary +1ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mary',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '6670bafc-d888-4736-ba03-71cdaeddaab1',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mary' }
visualization:5000   ilp-core getQuote: ignoring remote quote error: This connector does not support the given asset pair +0ms
ledger:3005 2017-04-06T04:32:22.676Z ledger:messages debug mark -> alice: { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9', method: 'error', data: { id: 'AssetsNotTradedError', message: 'This connector does not support the given asset pair' } }
ledger:3005 2017-04-06T04:32:22.676Z ledger:notificationBroadcaster debug emitting notification:{alice,*}:message.send
ledger:3005 2017-04-06T04:32:22.676Z ledger:koa info --> POST /messages 201 5ms 295B
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mark +3ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mark',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mark' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mark +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mark',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mark' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mark +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mark',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mark' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mark +1ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mark',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mark' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mark +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mark',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mark' }
visualization:5000   ilp-plugin-bells:translate notify message http://localhost:3005/accounts/mark +0ms
visualization:5000 message { ledger: 'http://localhost:3005',
visualization:5000   from: 'http://localhost:3005/accounts/mark',
visualization:5000   to: 'http://localhost:3005/accounts/alice',
visualization:5000   data: 
visualization:5000    { id: '3f12cf9c-2fff-4277-99f0-ff8dfe6e61d9',
visualization:5000      method: 'error',
visualization:5000      data: 
visualization:5000       { id: 'AssetsNotTradedError',
visualization:5000         message: 'This connector does not support the given asset pair' } },
visualization:5000   account: 'http://localhost:3005/accounts/mark' }
visualization:5000   ilp-core getQuote: ignoring remote quote error: This connector does not support the given asset pair +1ms
visualization:5000 2017-04-06T04:32:22.680Z error-handler ERROR Error: Got empty quote response from the connector
visualization:5000     at client.connect.then.then (/home/afx/five-bells-demo/node_modules/ilp/src/lib/sender.js:112:17)
visualization:5000     at process._tickCallback (internal/process/next_tick.js:103:7)
visualization:5000 2017-04-06T04:32:22.680Z error-handler ERROR Error: Got empty quote response from the connector
visualization:5000     at client.connect.then.then (/home/afx/five-bells-demo/node_modules/ilp/src/lib/sender.js:112:17)
visualization:5000     at process._tickCallback (internal/process/next_tick.js:103:7)
visualization:5000 2017-04-06T04:32:22.680Z koa INFO   xxx PUT /payments 500 66ms -
visualization:5000   InternalServerError: Error: Got empty quote response from the connector
visualization:5000       at Object.throw (/home/afx/five-bells-demo/node_modules/koa/lib/context.js:89:23)
visualization:5000       at Object.handleError (/home/afx/five-bells-demo/node_modules/five-bells-shared/middlewares/error-handler.js:18:19)
visualization:5000       at handleError.throw (<anonymous>)
visualization:5000       at onRejected (/home/afx/five-bells-demo/node_modules/co/index.js:81:24)
visualization:5000       at process._tickCallback (internal/process/next_tick.js:103:7)

What am I doing wrong?