Transaction took 10 minutes to be relayed #3770

I just noticed today that a new transaction I created took 10 minutes before it was requested by the connected nodes. Any ideas why?

extract from debug.log:-

2014-02-28 20:57:10 AddToWallet 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 new 2014-02-28 20:57:10 AddToWallet 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539
2014-02-28 20:57:10 Relaying wtx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 2014-02-28 21:07:09 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:8 2014-02-28 21:07:12 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:4 2014-02-28 21:07:12 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:2 2014-02-28 21:07:14 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:6 2014-02-28 21:07:17 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:3 2014-02-28 21:07:22 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:1 2014-02-28 21:07:23 received getdata for: tx 18e28621e3230b3cc89d8d30ec6a76227a9084ed2ec0352b48a9315c6ee03539 from node:7

As a side note, why is AddToWallet being run twice?

Probably because your internet is broken.

@luke-jr hmmm. ok, maybe we/I need to add some debugging lines to show when invs are sent to help work out what's going on here.. I'll get on it. I guess I'm the only person noticing this so far.

Calling AddToWallet multiple times is expected: the function is also called when the status of a transaction changes, it's not really AddToWallet but more like AddOrUpdateToWallet.