Menu

Sending thread timed out Failed to join sender thread

2021-07-05
2021-07-05
  • jason znack

    jason znack - 2021-07-05

    Hello, I'm having some trouble getting a transfer to start on a machine that is using a 2x1Gb Link Aggregation

    The NIC is an Intel Dual gigabit and the LAG is setup as 802.3ad to a Unifi switch. Normal transfers work fine with activity on both links.

    However, when I try to initiate a UFTP transfer, it announces, and then fails with Sending thread timed out and Failed to join sender thread.

    I can successfully send transfers from another machine on the network that doesn't have a dual port NIC, and it can actually send to other PCs on another switch that is also behind a switch to switch LAG. So I'm not actually sure if the LAG is the problem, or something else.

    Here are the command lines used during the test:

    Server side command: uftp.exe -R -1 -L uftplog.log -g 10 -n 100 -Y none -m 10 -b 8800 -B 104857600 C:\UFTP\Testfiles
    
    Client side command: uftpd.exe -L uftplog.log -g 10 -n 100 -c 10485760 -B 104857600
    

    See the log below.

    2021/07/02 23:29:46.856588: [D69713C8/00:0]: UFTP version 5.0  Copyright (C) 2001-2020  Dennis A. Bush
    2021/07/02 23:29:46.856588: [D69713C8/00:0]: Transfer rate: full interface speed
    2021/07/02 23:29:46.857087: [D69713C8/00:0]: Using private multicast address 230.5.5.182  Group ID: D69713C8
    2021/07/02 23:29:46.857087: [D69713C8/00:0]: Initializing group
    2021/07/02 23:29:46.857087: [D69713C8/00:0]: Sending ANNOUNCE 1
    2021/07/02 23:29:46.871096: [D69713C8/00:0]: Received REGISTER from client 0xBE4EDFF3
    2021/07/02 23:29:46.871596: [D69713C8/00:0]: Received REGISTER from client 0x84050AFA
    2021/07/02 23:29:46.872096: [D69713C8/00:0]: Received REGISTER from client 0xE49F8A30
    2021/07/02 23:29:46.873096: [D69713C8/00:0]: Received REGISTER from client 0xF4FAE9C1
    2021/07/02 23:29:46.873596: [D69713C8/00:0]: Received REGISTER from client 0xDACB45F3
    2021/07/02 23:29:46.873596: [D69713C8/00:0]: Received REGISTER from client 0x09456211
    2021/07/02 23:29:46.875908: [D69713C8/00:0]: Received REGISTER from client 0x0E5DEF92
    2021/07/02 23:29:46.885602: [D69713C8/00:0]: Received REGISTER from client 0x2FCFD7C5
    2021/07/02 23:29:46.885940: [D69713C8/00:0]: Received REGISTER from client 0x468C14CC
    2021/07/02 23:29:46.885940: [D69713C8/00:0]: Received REGISTER from client 0x6002FA11
    2021/07/02 23:29:46.886942: [D69713C8/00:0]: Received REGISTER from client 0x55D800E2
    2021/07/02 23:29:46.887942: [D69713C8/00:0]: Received REGISTER from client 0xDFCFE183
    2021/07/02 23:29:48.362887: [D69713C8/00:0]: Sending REG_CONF 2.1
    2021/07/02 23:29:48.362887: [D69713C8/00:0]: Sending ANNOUNCE 2
    2021/07/02 23:29:48.364469: [D69713C8/00:0]: Received REGISTER+ from client 0x84050AFA
    2021/07/02 23:29:48.364469: [D69713C8/00:0]: Received REGISTER+ from client 0xDACB45F3
    2021/07/02 23:29:48.364608: [D69713C8/00:0]: Received REGISTER+ from client 0x09456211
    2021/07/02 23:29:48.364745: [D69713C8/00:0]: Received REGISTER+ from client 0xBE4EDFF3
    2021/07/02 23:29:48.364942: [D69713C8/00:0]: Received REGISTER+ from client 0x55D800E2
    2021/07/02 23:29:48.424159: [D69713C8/00:0]: Sending REG_CONF 3.1
    2021/07/02 23:29:48.424159: [D69713C8/00:0]: Sending ANNOUNCE 3
    2021/07/02 23:29:48.485348: [D69713C8/00:0]: Sending ANNOUNCE 4
    2021/07/02 23:29:48.546796: [D69713C8/00:0]: Sending ANNOUNCE 5
    2021/07/02 23:29:48.608431: [D69713C8/00:0]: Sending ANNOUNCE 6
    2021/07/02 23:29:48.669578: [D69713C8/00:0]: Sending ANNOUNCE 7
    2021/07/02 23:29:48.731307: [D69713C8/00:0]: Sending ANNOUNCE 8
    2021/07/02 23:29:48.792882: [D69713C8/00:0]: Sending ANNOUNCE 9
    2021/07/02 23:29:48.854920: [D69713C8/00:0]: Sending ANNOUNCE 10
    2021/07/02 23:29:48.916145: [D69713C8/00:0]: Sending ANNOUNCE 11
    2021/07/02 23:29:48.977857: [D69713C8/00:0]: Sending ANNOUNCE 12
    2021/07/02 23:29:49.039920: [D69713C8/00:0]: Sending ANNOUNCE 13
    2021/07/02 23:29:49.101922: [D69713C8/00:0]: Sending ANNOUNCE 14
    2021/07/02 23:29:49.163979: [D69713C8/00:0]: Sending ANNOUNCE 15
    2021/07/02 23:29:49.226027: [D69713C8/00:0]: Sending ANNOUNCE 16
    2021/07/02 23:29:49.287339: [D69713C8/00:0]: Sending ANNOUNCE 17
    2021/07/02 23:29:49.348655: [D69713C8/00:0]: Sending ANNOUNCE 18
    2021/07/02 23:29:49.410219: [D69713C8/00:0]: Sending ANNOUNCE 19
    2021/07/02 23:29:49.471761: [D69713C8/00:0]: Sending ANNOUNCE 20
    2021/07/02 23:29:49.533692: [D69713C8/00:0]: ----- testfiles -----
    2021/07/02 23:29:49.533692: [D69713C8/00:0]: ----- testfiles/pack1 -----
    2021/07/02 23:29:49.533692: [D69713C8/00:0]: ----- testfiles/pack1/FeatureVideo-2021-06-30-1612-A.mp4 -----
    2021/07/02 23:29:49.533692: [D69713C8/00:0001]: File ID: 0001  Name: testfiles/pack1/FeatureVideo-2021-06-30-1612-A.mp4
    2021/07/02 23:29:49.533692: [D69713C8/00:0001]:   sending as: testfiles/pack1/FeatureVideo-2021-06-30-1612-A.mp4
    2021/07/02 23:29:49.533692: [D69713C8/00:0001]: Bytes: 125295046  Blocks: 14239  Sections: 1
    2021/07/02 23:29:49.533692: [D69713C8/00:0001]: Sending FILEINFO 1.1
    2021/07/02 23:29:49.547426: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x468C14CC
    2021/07/02 23:29:49.548295: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x2FCFD7C5
    2021/07/02 23:29:49.549442: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x6002FA11
    2021/07/02 23:29:49.549442: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x55D800E2
    2021/07/02 23:29:49.550942: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0xDFCFE183
    2021/07/02 23:29:49.582968: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x84050AFA
    2021/07/02 23:29:49.582968: [D69713C8/00:0001]: Sending FILEINFO 2.1
    2021/07/02 23:29:49.590472: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x09456211
    2021/07/02 23:29:49.590973: [D69713C8/00:0001]: Received FILEINFO_ACK+ from client 0x09456211
    2021/07/02 23:29:49.593587: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0xF4FAE9C1
    2021/07/02 23:29:49.593937: [D69713C8/00:0001]: Received FILEINFO_ACK+ from client 0xF4FAE9C1
    2021/07/02 23:29:49.594812: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0xBE4EDFF3
    2021/07/02 23:29:49.595353: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0x0E5DEF92
    2021/07/02 23:29:49.595457: [D69713C8/00:0001]: Received FILEINFO_ACK+ from client 0xBE4EDFF3
    2021/07/02 23:29:49.595457: [D69713C8/00:0001]: Received FILEINFO_ACK+ from client 0x0E5DEF92
    2021/07/02 23:29:49.595958: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0xE49F8A30
    2021/07/02 23:29:49.596458: [D69713C8/00:0001]: Received FILEINFO_ACK+ from client 0xE49F8A30
    2021/07/02 23:29:49.597457: [D69713C8/00:0001]: Received FILEINFO_ACK from client 0xDACB45F3
    2021/07/02 23:29:49.597457: [D69713C8/00:0001]: Received invalid message FILEINFO_ACK from 0xDACB45F3
    2021/07/02 23:29:49.597958: [D69713C8/00:0001]: Sending file
    2021/07/02 23:29:49.597958: [D69713C8/00:0001]: Starting pass 1
    2021/07/02 23:29:49.597958: [D69713C8/00:0001]: Sending section 0
    2021/07/02 23:29:49.786489: [D69713C8/00:0001]: Sending DONE 1.1
    2021/07/02 23:29:49.825496: [D69713C8/00:0001]: Sending DONE 2.1
    2021/07/02 23:29:49.864503: [D69713C8/00:0001]: Sending DONE 3.1
    2021/07/02 23:29:49.903509: [D69713C8/00:0001]: Sending DONE 4.1
    2021/07/02 23:29:49.942516: [D69713C8/00:0001]: Sending DONE 5.1
    2021/07/02 23:29:49.981522: [D69713C8/00:0001]: Sending DONE 6.1
    2021/07/02 23:29:50.020529: [D69713C8/00:0001]: Sending DONE 7.1
    2021/07/02 23:29:50.059535: [D69713C8/00:0001]: Sending DONE 8.1
    2021/07/02 23:29:50.098542: [D69713C8/00:0001]: Sending DONE 9.1
    2021/07/02 23:29:50.137549: [D69713C8/00:0001]: Sending DONE 10.1
    2021/07/02 23:29:50.176555: [D69713C8/00:0001]: Sending DONE 11.1
    2021/07/02 23:29:50.215562: [D69713C8/00:0001]: Sending DONE 12.1
    2021/07/02 23:29:50.254568: [D69713C8/00:0001]: Sending DONE 13.1
    2021/07/02 23:29:50.293575: [D69713C8/00:0001]: Sending DONE 14.1
    2021/07/02 23:29:50.332581: [D69713C8/00:0001]: Sending DONE 15.1
    2021/07/02 23:29:50.371588: [D69713C8/00:0001]: Sending DONE 16.1
    2021/07/02 23:29:50.410595: [D69713C8/00:0001]: Sending DONE 17.1
    2021/07/02 23:29:50.449601: [D69713C8/00:0001]: Sending DONE 18.1
    2021/07/02 23:29:50.488608: [D69713C8/00:0001]: Sending DONE 19.1
    2021/07/02 23:29:50.527614: [D69713C8/00:0001]: Sending DONE 20.1
    2021/07/02 23:29:50.527614: [D69713C8/00:0001]: Sending thread timed out
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0xBE4EDFF3
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x84050AFA
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0xE49F8A30
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0xF4FAE9C1
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0xDACB45F3
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x09456211
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x0E5DEF92
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x2FCFD7C5
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x468C14CC
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x6002FA11
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0x55D800E2
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: No response from 0xDFCFE183
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Failed to join sender thread
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Transfer status:
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0xBE4EDFF3       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x84050AFA       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0xE49F8A30       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0xF4FAE9C1       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0xDACB45F3       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x09456211       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x0E5DEF92       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x2FCFD7C5       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x468C14CC       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x6002FA11       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0x55D800E2       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Host: 0xDFCFE183       Status: Lost connection
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Total elapsed time: 0.000 seconds
    2021/07/02 23:29:50.539945: [D69713C8/00:0001]: Overall throughput: 0.00 KB/s
    

    Thanks for your help.

     
  • jason znack

    jason znack - 2021-07-05

    And today I try again and it appears to be working ok. Nothing changed though as far as I know.

     
  • Dennis Bush

    Dennis Bush - 2021-07-05

    When troubleshooting issues like this, try doing a packet capture on both sides to make sure the network adapter is actually receiving the data.

     
    • jason znack

      jason znack - 2021-07-05

      Thanks, I'll do that if it happens again.

       

Log in to post a comment.

Want the latest updates on software, tech news, and AI?
Get latest updates about software, tech news, and AI from SourceForge directly in your inbox once a month.