Tox protocol

[lx]

After recent updates can`t  set online.

Code: [Select]

[spoiler=VersionInfo][quote]CPU: Intel(R) Core(TM) i7-4510U CPU @ 2.00GHz [Intel64 Family 6 Model 69 Stepping 1] [DEP Enabled] [4 CPUs]
Installed RAM: 7633 MBytes
Operating System: Microsoft Windows 8.1 Professional Edition, 64-bit (build 9600)
Internet Explorer: 9.11.9600.17801 (build 99600)
Administrator privileges: Yes
OS Languages: (UI | Locale (User/System)) : Russian/Russian | Russian/Russian
Free disk space on Miranda partition: 34318 MBytes

Miranda NG Version: 0.95.5 alpha build #13823 x64
Build time: 25 May 2015 5:42:16
Profile: C:\Users\lx\Documents\Miranda NG\Profiles\lx\lx.dat
Profile size: 589824 Bytes
Profile creation date: 18 May 2015 11:01:08
Language pack: Russian (RU) [0419]
Service Mode: No

[b]Active Plugins (13):[/b]
  AdvaImg.dll v.[b]0.11.0.2[/b] [25 May 2015 5:43:22] - Miranda image services
  AVS.dll v.[b]0.95.3.4[/b] [25 May 2015 5:42:26] - Avatar service
  Clist_modern.dll v.[b]0.9.1.3[/b] [24 May 2015 14:11:34] - Modern contact list
  CrashDumper.dll v.[b]0.0.5.2[/b] [24 May 2015 14:12:46] - Crash dumper
  Dbx_mmap.dll v.[b]0.95.3.1[/b] [25 May 2015 5:42:30] - Miranda NG mmap database driver
  ICQ.dll v.[b]0.11.3.4[/b] [25 May 2015 5:43:10] - IcqOscarJ protocol
  Import.dll v.[b]0.95.4.2[/b] [25 May 2015 5:42:26] - Import contacts and messages
  IRC.dll v.[b]0.11.0.3[/b] [24 May 2015 14:08:36] - IRC protocol
  Jabber.dll v.[b]0.11.0.4[/b] [24 May 2015 14:09:18] - Jabber protocol
  PluginUpdater.dll v.[b]0.1.2.4[/b] [24 May 2015 14:13:16] - Plugin updater
  Scriver.dll v.[b]2.12.1.2[/b] [25 May 2015 5:42:36] - Scriver
  TopToolBar.dll v.[b]0.8.0.4[/b] [24 May 2015 14:11:14] - TopToolBar
  Tox.dll v.[b]0.11.1.6[/b] [24 May 2015 14:17:32] - Tox protocol

[b]Unloadable Plugins (2):[/b]
  DbChecker.dll v.[b]0.0.0.0[/b] [25 May 2015 5:46:38] - <unknown>

  libtox.dll v.[b]0.0.0.0[/b] [19 May 2015 11:18:25] - <unknown>
    This dll is not a Miranda plugin and should be removed from plugins directory


[b]Protocols and Accounts:[/b]
-------------------------------------------------------------------------------
ICQ                      2 - Enabled 0 - Disabled  Loaded
IRC                      1 - Enabled 0 - Disabled  Loaded
JABBER                   0 - Enabled 1 - Disabled  Loaded
TOX                      1 - Enabled 0 - Disabled  Loaded
MetaContacts             1 - Enabled 0 - Disabled  Loaded

[b]Icon Packs:[/b]
-------------------------------------------------------------------------------
 Proto_ICQ.dll [25 May 2015 5:45:08]
 Proto_IRC.dll [24 May 2015 14:11:16]
 Proto_Jabber.dll [24 May 2015 14:11:16]
 Proto_MetaContacts.dll [25 May 2015 5:49:46]
 Proto_Tox.dll [24 May 2015 14:17:22]
 Toolbar_icons.dll [24 May 2015 14:11:18]
 xStatus_ICQ.dll [25 May 2015 5:43:30]
 xStatus_Jabber.dll [24 May 2015 14:09:28]
[/quote][/spoiler]

[Robyer]

lx, folders structure in download archives are prepared just for extraction into Miranda's root folder.

So, libtox.dll should be in Miranda's root folder, not in plugins folder.

If this won't help, then provide network log, as usual.

[lx]

Robyer, it has always been there)
But thanx for tip to look into the options, I turned on UDP and IP6 and somehow Tox took online status.
What is for logs - I have enabled it as described in wiki and reproduced error, but catalog c:\Users\lx\Documents\Miranda NG\Profiles\lx\Logs\ is empty.
Anyway, Tox plugin is working, many thanx!

[Vulpix]

Hello lx,

You are actually correct, I just tested it; tox is unable to connect in TCP-only mode right now (on miranda). @unsane

[Vulpix]

When transferring files to/from people with slower connection, miranda causes the other contact to disconnect and upon reconnection, it is unable to resume the file.

This makes sending/receiving files from people with slower/less reliable connections (=most of the world) almost impossible.

Would it be possible to re-implement the file resuming? More importantly, when I use uTox (v0.3.0) with my friend for the same file transfer, it is transferred without issues. The speed is very erratic but there are no disconnects or issues during the transfer. Miranda transfer fails after 10-40 seconds (randomly). Filesize was 6MB. Then I restarted my miranda and tried to get him to send me the file again, but it was impossible to get it. It always just never started.

My netlog:

[14:03:48 1E40] CToxProto::SetStatus: changing status from 40071 to 40072
[14:03:48 63BC] CToxProto::PollingThread: entering
[14:03:48 63BC] CToxProto::InitToxCore: initializing tox core
[14:03:48 63BC] CToxProto::InitToxCore: loading tox profile
[14:03:48 63BC] CToxProto::LoadToxProfile: loading tox profile
[14:03:48 63BC] CToxProto::LoadToxProfile: tox profile load successfully
[14:03:48 63BC] CToxProto::BootstrapNodes: bootstraping DHT
[14:03:55 63BC] CToxProto::TryConnect: successfuly connected to DHT
[14:03:55 63BC] CToxProto::TryConnect: changing status from 1 to 40072
[14:03:56 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:03:57 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:04:06 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:04:08 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:04:09 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:04:10 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:04:10 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:04:11 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:04:12 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:04:13 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:04:16 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:04:17 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:06:25 1E40] CToxProto::OnFileResume: start receiving file (65536) to (8)
[14:06:33 1E40] CToxProto::OnFileResume: start receiving file (65536) to (8)
[14:06:55 63BC] CToxProto::OnConnectionStatusChanged: sending ask to resume the transfer of file (65536)
[14:06:55 63BC] CToxProto::OnConnectionStatusChanged: failed to resume the transfer (3)
[14:06:56 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:06:57 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)
[14:07:18 1E40] CToxProto::OnFileResume: start receiving file (65536) to (8)
[14:07:18 1E40] CToxProto::OnFileResume: failed to start the transfer of file(65536) to (8): (3)
[14:07:44 63BC] CToxProto::OnFileRequest: start/resume the transfer of file (0)
[14:07:45 63BC] CToxProto::OnFileSendData: finised the transfer of file (0)

then he tried to send the screenshot:

[14:10:34 1E40] CToxProto::OnFileResume: start receiving file (65536) to (8)
[14:10:55 63BC] CToxProto::OnConnectionStatusChanged: sending ask to resume the transfer of file (65536)
[14:10:55 63BC] CToxProto::OnConnectionStatusChanged: failed to resume the transfer (3)


Friend is using uTox, his screen looked like this (attachment).

Thanks!

[Vulpix]

Robyer, it has always been there)
But thanx for tip to look into the options, I turned on UDP and IP6 and somehow Tox took online status.
What is for logs - I have enabled it as described in wiki and reproduced error, but catalog c:\Users\lx\Documents\Miranda NG\Profiles\lx\Logs\ is empty.
Anyway, Tox plugin is working, many thanx!

@lx , the tcp-only mode is working now again.

[Vulpix]

Tox causes disconnection of the target of transfer. This is a toxcore issue and should be fixed in toxcore (happens even on uTox). However, utox is able to resume the transfer; miranda is not.

Below is the log from my attempt to send a file to a friend (34):


[23:25:59 0F24] CToxProto::OnSendFile: start sending file (0) to (24)
[23:26:47 341C] CToxProto::OnFileSendData: finised the transfer of file (0) to (24)
[23:29:53 0F24] CToxProto::OnSendFile: start sending file (0) to (34)
[23:30:47 341C] CToxProto::PauseOutgoingTransfers: sending ask to pause the transfer of file (0) to (34)
[23:30:47 341C] CToxProto::PauseOutgoingTransfers: failed to pause the transfer (0) to (34) cause(2)
[23:30:49 0F24] CToxProto::OnSendMessage: failed to send message (3)
[23:32:58 341C] CToxProto::OnFriendFile: incoming file (65536) from (24)
[23:33:03 0F24] CToxProto::OnFileResume: start receiving file (65536) from (24)
[23:33:05 341C] CToxProto::OnTransferCompleted: finised the transfer of file (65536) from (24)
[23:33:08 341C] CToxProto::OnFriendFile: incoming avatar (65536) from (34)
[23:33:08 341C] CToxProto::OnFileCancel: Transfer (65536) is canceled

After about 1MB of the file is sent, the friend disconnects. Comes back ~2 minutes later but the transfer shows up as "File transfer denied" and does not resume.

[Vulpix]

More strange logs - I have no idea what is happening in miranda during this time.

Entire log up for download as an attachment, too long to paste in.

[Vulpix]

File transfers are just broken and unreliable right now. Even small files <64 kB can get stuck, not sent, etc.

I.e.:

12:31:25 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:25 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:25 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:25 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:33 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:33 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:33 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:33 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:41 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:41 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:41 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:41 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:49 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:49 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:49 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:31:49 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:31:53 241C] CToxProto::OnSendFile: start sending file (0) to (0)
[12:32:05 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:32:05 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:32:05 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:32:05 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:32:09 241C] CToxProto::OnSendFile: start sending file (0) to (0)
[12:32:21 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:32:21 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:32:21 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:32:21 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:32:53 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:32:53 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:32:53 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:32:53 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:09 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:09 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:09 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:09 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:17 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:17 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:17 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:17 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:25 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:25 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:25 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:25 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:33 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:33 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:33 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:33 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:41 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:41 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled
[12:33:41 39C0] CToxProto::OnFriendFile: incoming avatar (65536) from (0)
[12:33:41 39C0] CToxProto::OnFileCancel: Transfer (65536) is canceled

[Vulpix]

File transfers are working, however, sometimes (usually after being online for some time), the first time you try to transfer something, it won't work.

The recipient will see the prompt and will be able to start saving the file, but the file sending gets stuck on 1% and never finishes.

If you then try to cancel and resend the file again, it will not be possible due to file locks.

The transfer is from miranda to miranda, both always on latest dev version of miranda.

Below is the sender log for this:

18:11 -> I tried to send a file, but it got stuck at 1% and did nothing. So I didn't do anything, and I was just chatting with the contact.
19:37 -> I tried to send a file, no problem. Seems that something happened that timed out the transfer from what I can see in the log.

[18:11:01 2588] CToxProto::OnSendFile: start sending file (0) to (0)
[18:21:32 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[18:21:33 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[18:28:59 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[18:29:21 1E38] CToxProto::PauseOutgoingTransfers: sending ask to pause the transfer of file (0) to (2)
[18:29:21 1E38] CToxProto::PauseOutgoingTransfers: failed to pause the transfer (0) to (2) cause(2)
[18:29:22 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[18:29:25 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[18:29:25 1E38] CToxProto::OnFileSendData: file (0) is not completely transferred to (2)
[18:53:47 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[18:53:48 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[19:00:17 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[19:00:18 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[19:00:40 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[19:00:42 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[19:33:13 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[19:33:15 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[19:33:44 1E38] CToxProto::OnFriendFile: incoming avatar (65536) from (2)
[19:33:47 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (2)
[19:37:34 2588] CToxProto::OnSendFile: start sending file (0) to (0)
[19:38:05 1E38] CToxProto::OnFileSendData: finised the transfer of file (0) to (0)


This happens constantly and it's really annoying because miranda creates 0byte files in the recipient's miranda file download directory, and you cannot overwrite it, you have to use rename when you try to send something again, and then it still doesn't work sometimes.

Can provide more logs if required. Both using TCP-only mode.

Otherwise the plugin is okay.

[unsane]

Vulpix, it should be fixed at version 0.11.1.11 

[Vulpix]

nice version number!

Anyway, it seems to be fixed, it didn't happen today! Thanks! I'll let you know if there is anything else.

Oh right.

Do you know what this means?


[0:51:01 1704] CToxProto::SetAwayMsg: failed to set status status message F (0)
[0:51:01 1704] CToxProto::SetAwayMsg: failed to set status status message F (0)
[0:51:07 1704] CToxProto::SetAwayMsg: failed to set status status message F (0)
[0:51:07 1704] CToxProto::SetStatus: changing status from 40072 to 40073
[0:51:08 1704] CToxProto::SetAwayMsg: failed to set status status message A (0)
[0:51:12 1704] CToxProto::SetAwayMsg: failed to set status status message A (0)
[0:51:12 1704] CToxProto::SetStatus: changing status from 40073 to 40072
[0:51:14 1704] CToxProto::SetAwayMsg: failed to set status status message F (0)


My statuses at that time were "Awaypix" and "Fivetail", so it's clearly that 'A' and 'F'. Maybe one of those encoding changes that happened with the miranda changes recently. Is something broken?

[Vulpix]

So it happened again today:

There is NOTHING useful in the log. At all.

Sender side only has this:
[10:23:04 27D8] CToxProto::OnSendFile: start sending file (0) to (0)


Recipient side:
[10:23:01 1044] CToxProto::OnFriendFile: incoming file (65536) from (0) <- me sending the file
[10:23:18 1398] CToxProto::OnFileResume: start receiving file (65536) from (0) <- my contact accepted it, it started, went to a progress bar but no progress has been filled
[10:23:48 1398] CToxProto::OnFileCancel: Transfer (65536) is canceled <- he cancelled the transfer when he realized that it's the bug again.


I am using tcp-only mode, my contact is using udp as well. We both have latest dev version of miranda as always.

This only happens after I (sender) have been online for a very long time (since yesterday). Is it possible that something in there times out or whatever?

It's very frustrating :<

[unsane]

Irungentoo (the main developer of Toxcore) started fundraising for tox development.
If someone interesting https://www.indiegogo.com/projects/toxcore-development.

[Vulpix]

Right-clicking a contact and selecting "read online message" or "copy online message" shows "failed to read online message". It's a bit annoying if I want to copy a link someone uses as their status; I always have to re-type it.