easly1989 / ffxiv_act_dfassist

Duty Finder Assist Plugin for ACT, Based on https://github.com/devunt/DFAssist
GNU General Public License v3.0
83 stars 37 forks source link

DFAssist not working at all #6

Closed Aiakio closed 5 years ago

Aiakio commented 5 years ago

Version: 1.4.4 (earlier versions didnt work either)

So, when i launch ACT, DFAssist tells me, that toasts are working fine. The logs in ACT seem also fine: "Detected Game Server Connection" 30 or 40 times. When in game, i dont get any toasts, though.

I tried to "Enable Test Environment", but that didnt work. Game, or ACT restart also doesnt get it to work. Weird enough, through a VPN it worked... Just tried it because i was experimenting with it, but, well, would be nice if it would work without a VPN too. :)

Let me know if you need any logs or anything that helps you analyze this issue.

DAOWAce commented 5 years ago

For me, I have W10 style notifications disabled because they're atrocious and I'm an oldschool Windows user (ex: https://www.askvg.com/windows-10-tip-disable-toast-notifications-and-enable-classic-balloon-tips), so they don't work for me, but I expected to at least be able to see it in the log.

However, the log previously spammed errors with 1.4.2 when a DF was counting down. There's no error spam now, but it doesn't display the duty in the log, unless this is it: [19:58:26] Q: Matched [653]

Is that the duty? If so, can it be translated within the log so we can actually read it?

That aside, getting this to work with legacy balloon notifications would be quite helpful for power users like me.. or anyone not on W10.

easly1989 commented 5 years ago

Back when there was support for windows 7 I made some custom toasts, I may take those back and let you decide which one to use.

You will loose the ability to make toasts permanent (as they will not show anymore in the Notifcation bar)

@Aiakio problem seems different btw, it is like a network connection issue, otherwise using a VPN should not solve his problem.

But, as far as I can tell, this is also the first network issue anyone finds with the plugin.

So there are multiple things to correct and check. I'll try to put up asap something to test out the network connection and fix the log (to show the name of the dungeon instead of the Id) then I'll work on some legacy baloon (I'm still searching a way to print the message directly in game..)

Aiakio commented 5 years ago

(to show the name of the dungeon instead of the Id)

Sadly it doesnt even show the dungeon ID. It just says:

[08:54:30] P: FFXIV Process Selected: 5456
[08:54:30] N: Starting Network Reading...
[08:54:30] N: Detected Game Server Connection: 127.0.0.1:54842 -> 127.0.0.1:9010
[08:54:30] N: Detected Game Server Connection: 192.168.178.21:54862 -> 195.82.50.9:54994
[08:54:30] N: Started Reading Network Packet

And thats it. While going through the roulettes, nothing in the log changes.

Another thing i didnt mention above is, that via VPN it only works if i split-tunnel the game to have a direct connection (not over vpn) and have ACT running over the VPN. Obviously all the other ACT-Featurs and Plugins wont work anymore, only DFAssist does... lol. That is so strange.

easly1989 commented 5 years ago

@DAOWAce in 1.4.5 I've added a couple of QoL changes based on your suggestions:

@Aiakio Your problem is quite "unique"; I honestly dunno where to start to understand what is going wrong tbh. It seems like a network problem, but only with my plugin? There is a bit of code inside the app.config that I use to ensure that the plugin uses the current PC network policies, maybe that is the problem?

You can try this "custom" version DFAssist_noproxy.zip and tell me if it works (or if the things gets worse XD) Let me know!

p.s. I had to add this lines of code as from work I'm behind a strict proxy with credentials, and without it the plugin would not connect to internet.

Aiakio commented 5 years ago

Thanks for the zip. Sadly didnt work. Removed the one in ACT and installed the one in your zip manually. Do i need to copy the libs folder somewhere specific?

Still not even a dungeon id in the log. Nothing changed for the better or worse.^^

Dont worry about being fast. Dont wanna get you fired for doing private stuff at your job. xD

easly1989 commented 5 years ago

No problem, I do this when I can :) Anyway, you just need to replace all the content in the zip with your plugin (everything should be in the same directory, i have it in a Directory tree like this: ACT

Plugins

DFAssist Plugin

libs DFAssist.dll DFAssist.dll.config

I'm working on an overhaul of the graphic, and will ad some more logging, also to better diagnose network problems, but still I'm out of clues atm.

If you have the possibility to debug the code yourself (and understand what is happening) that would for sure help! Otherwise, you'll have to wait a bit (and hope) :(

Aiakio commented 5 years ago

Ok thats my folder structure too. Well, i have no idea about programming or debugging. So i just wait and hope now.^^

Thanks for your quick responses though :O If i find anything useful i will report it to you.

DeathToad commented 5 years ago

So I have the same issue as Aiakio. This is all my log will do even while running multiple roulettes throughout the day:

[09:06:36] P: FFXIV Process Selected: 32264
[09:06:36] N: Starting Network Reading...
[09:06:38] N: Detected Game Server Connection: 127.0.0.1:49687 -> 127.0.0.1:9010
[09:06:38] N: Detected Game Server Connection: 127.0.0.1:49750 -> 127.0.0.1:9010
[09:06:38] N: Detected Game Server Connection: 192.168.1.100:49768 -> 204.2.229.86:55007
[09:06:38] N: Detected Game Server Connection: 192.168.1.100:49769 -> 204.2.229.86:55007
[09:06:38] N: Detected Game Server Connection: 127.0.0.1:49785 -> 127.0.0.1:9010
[09:06:38] N: Detected Game Server Connection: 127.0.0.1:49792 -> 127.0.0.1:9010
[09:06:43] N: Started Reading Network Packet

So I'm not sure why it's not working but thought I'd let you know I got the same issue.

Edit:

I tried using the above zip you linked and same issue just longer log:

[11:40:28] P: FFXIV Process Selected: 32264
[11:40:28] N: Starting Network Reading...
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:49687 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:49750 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 192.168.1.100:49768 -> 204.2.229.86:55007
[11:40:30] N: Detected Game Server Connection: 192.168.1.100:49769 -> 204.2.229.86:55007
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:49785 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:49792 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:49847 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:49871 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:50678 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:50942 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:50950 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:51854 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:52389 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:52427 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:52473 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:52586 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:53174 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:53682 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:53899 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:53970 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:53994 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:54472 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:54515 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:54787 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55034 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55173 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55176 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55214 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55237 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55264 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55274 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55290 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55307 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55316 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55344 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55504 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55516 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55547 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55577 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55638 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55711 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55733 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55846 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:55997 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56018 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56130 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56195 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56239 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56354 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56405 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56416 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56431 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56495 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56548 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56554 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56609 -> 127.0.0.1:9010
[11:40:30] N: Detected Game Server Connection: 127.0.0.1:56696 -> 127.0.0.1:9010
[11:40:35] N: Started Reading Network Packet
DAOWAce commented 5 years ago

Well that was fast.

I get "[14:33:50] <A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.>" in my log, but it still seems to work just fine at detecting duty.

Legacy toasts half work; I see the test notification, but not the actual notification. It shows the text of duty in the log though.. and TTS mentions it which I didn't realize at the time of posting which could've been used as a workaround, so it doesn't matter too much now.

Thank you for the quick update.

EDIT: Nevermind, I do see the notifications, and hear them.. it's just that I can't see them with the game window maximized despite being in borderless mode. It's a custom style toast window that just doesn't display ontop of anything.

Aiakio commented 5 years ago

Hey @DeathToad, sorry that you also have this problem. On the other hand i'm happy i'm not alone.^^

My logs are also different in length. Sometimes its like 30 or 40 entries, sometimes its just 2 or 5 or so. But this was always the case for me. Not just with the noproxy custom version.

Also, i dont know if this is of any interest to you, @easly1989: Im using Windows Insider Build 18941.1001

DeathToad commented 5 years ago

@Aiakio, Ah I haven't paid attention until now about the length of the log. I thought most of them were on the smaller size when I've looked. Anyway yeah, if it helps @easly1989 I'm running Windows 10 Pro.

easly1989 commented 5 years ago

It seems to be related to some network issue... Anyway, tomorrow I'll have some work outside the office, that means I'll not be able to continue my testing.

As soon as I've the possibility I'll put up all the logs and the new UI and we'll probably (hopefully) be able to diagnose the root of the problem!

Until then, if you can try older releases of the assist and see if it ever worked (or even try to make a clean installation of ACT and the assist) and report back it would be awesome.

Sorry again for the inconvenience! 😣

Aiakio commented 5 years ago

if you can try older releases of the assist and see if it ever worked (or even try to make a clean installation of ACT and the assist) and report back it would be awesome.

I did try both of these. Redownloaded everything and set it up completely new: Didn't work. And older releases also dont work for me.

Sorry again for the inconvenience! 😣

Dont worry. Dont stress yourself. You doing a great job. :)

DeathToad commented 5 years ago

@easly1989, No rush, I'm on vacation and won't be home for awhile so it doesn't bother me.

easly1989 commented 5 years ago

Just commited version 1.5.0 (Already found a minor bug about Localization, will fix it soon, but i'll wait to make a new release until we found the root of the issue here!)

Now the Inizialization of the Plugin is more "verbose" and also every setting should print a "reaction" in the log window.

So you may try it and tell me what you see! The standard output for inizialization is this:

[16:03:41] > ---------------------------------------------------------------- [16:03:41] > Plugin Init [16:03:41] > Plugin Version: 1.5.0.0 [16:03:41] > Initializing Localization... [16:03:41] > Localization Initialized, for language: en-us! [16:03:41] > Initializing Data... [16:03:41] > Data 20190628,2 Initialized! [16:03:41] > Shortcut for ACT found [16:03:41] > Plugin Enabled [16:03:41] > Plugin Started! [16:03:41] > Settings Loading... [16:03:41] > [DisableToasts] Desired Value: True! [16:03:41] > Language: English [16:03:41] > Disable Toasts: True [16:03:41] > Make Toasts Persistent: False [16:03:41] > Enable Legacy Toasts: False [16:03:41] > Enable Text To Speech: False [16:03:41] > Enable Test Environment: True [16:03:41] > Settings Loaded! [16:03:41] > Request Showing Taost received... [16:03:41] > ... Toasts are disabled! [16:03:41] > ----------------------------------------------------------------

having toasts disabled; And this one

[16:04:36] > ---------------------------------------------------------------- [16:04:36] > Plugin Init [16:04:36] > Plugin Version: 1.5.0.0 [16:04:36] > Initializing Localization... [16:04:36] > Localization Initialized, for language: en-us! [16:04:36] > Initializing Data... [16:04:36] > Data 20190628,2 Initialized! [16:04:36] > Shortcut for ACT found [16:04:36] > Plugin Enabled [16:04:36] > Plugin Started! [16:04:36] > Settings Loading... [16:04:36] > Language: English [16:04:36] > Disable Toasts: False [16:04:36] > Make Toasts Persistent: False [16:04:36] > Enable Legacy Toasts: False [16:04:36] > Enable Text To Speech: False [16:04:36] > Enable Test Environment: True [16:04:36] > Settings Loaded! [16:04:36] > Request Showing Taost received... [16:04:36] > ... Legacy Toasts Disabled... [16:04:36] > ... Creating new Toast... [16:04:36] > ... Toast Showing... [16:04:36] > ----------------------------------------------------------------

having them enabled.

I know that this probably will work ok for you, as the problem may be in the FFXIV packet network analyzer.. But for the moment... we can at least be sure that everything starts in the proper way.

ps. I'm still from my office and I don't actually have FFXIV launched. Thats is why you don't see anything related to FF in the log. So if you can do this test, with and without FF started would be a good insight :)

easly1989 commented 5 years ago

@Aiakio @DeathToad When possible, please give a try at this this custom version

Be sure to delete the older version of the plugin first, to avoid libraries conflicts!

I may have found the problem you were experiencing! Let me know :)

Aiakio commented 5 years ago

Without FF launched:

[17:41:23]  > ----------------------------------------------------------------
[17:41:23]  > Plugin Init
[17:41:23]  > Plugin Version: 1.5.0.0
[17:41:23]  > Initializing Localization...
[17:41:23]  > Localization Initialized, for language: en-us!
[17:41:23]  > Initializing Data...
[17:41:23]  > Data 20190628.2 Initialized!
[17:41:23]  > Shortcut for ACT found
[17:41:23]  > Plugin Enabled
[17:41:23]  > Plugin Started!
[17:41:23]  > Settings Loading...
[17:41:23]  > Language: English
[17:41:23]  > Disable Toasts: False
[17:41:23]  > Make Toasts Persistent: False
[17:41:23]  > Enable Legacy Toasts: False
[17:41:23]  > Enable Text To Speech: False
[17:41:23]  > Enable Test Environment: False
[17:41:23]  > Settings Loaded!
[17:41:23]  > Request Showing Taost received...
[17:41:23]  > ... Legacy Toasts Disabled...
[17:41:23]  > ... Creating new Toast...
[17:41:23]  > ... Toast Showing...
[17:41:23]  > ----------------------------------------------------------------

When the game is launched first, then ACT and then queue up in a roulette:

[17:52:43]  > ----------------------------------------------------------------
[17:52:43]  > Plugin Init
[17:52:43]  > Plugin Version: 1.5.0.0
[17:52:43]  > Initializing Localization...
[17:52:44]  > Localization Initialized, for language: en-us!
[17:52:44]  > Initializing Data...
[17:52:44]  > Data 20190628.2 Initialized!
[17:52:44]  > Shortcut for ACT found
[17:52:44]  > Plugin Enabled
[17:52:44]  > Plugin Started!
[17:52:44]  > Settings Loading...
[17:52:44]  > Language: English
[17:52:44]  > Disable Toasts: False
[17:52:44]  > Make Toasts Persistent: False
[17:52:44]  > Enable Legacy Toasts: False
[17:52:44]  > Enable Text To Speech: False
[17:52:44]  > Enable Test Environment: True
[17:52:44]  > Settings Loaded!
[17:52:44] P: FFXIV Process Selected: 1096
[17:52:44] N: Starting Network Reading...
[17:52:44]  > Request Showing Taost received...
[17:52:44]  > ... Legacy Toasts Disabled...
[17:52:44]  > ... Creating new Toast...
[17:52:44]  > ... Toast Showing...
[17:52:44]  > ----------------------------------------------------------------
[17:52:44] N: Detected Game Server Connection: 192.168.178.21:64571 -> 195.82.50.50:55024
[17:52:44] N: Detected Game Server Connection: 192.168.178.21:64572 -> 195.82.50.50:55024
[17:52:44] N: Detected Game Server Connection: 127.0.0.1:65166 -> 127.0.0.1:9010
[17:52:44] N: Started Reading Network Packet
[17:52:57] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:52:57] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:53:21] Q: Matching Stopped
[17:53:21] Q: Matching Stopped
[17:53:25] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:53:25] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:53:55] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:54:01]  > Request Showing Taost received...
[17:54:01]  > ... Legacy Toasts Disabled...
[17:54:01]  > ... Creating new Toast...
[17:54:01]  > ... Toast Showing...
[17:54:01] Q: Matched [188] - A - Heart of the Creator
[17:54:04] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:54:06] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:54:08] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:54:11] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:54:36] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[17:54:36] Q: Entered Instance Area

It is working! Even though the log isn't looking that great with all the red error messages lol.

EDIT: Above tests are with the regular v1.5.0, not the custom version. Trying custom now and will report back.

Aiakio commented 5 years ago

When possible, please give a try at this this custom version

Custom version not working.

[18:33:43]  > ----------------------------------------------------------------
[18:33:43]  > Plugin Init
[18:33:43]  > Plugin Version: 1.5.0.0
[18:33:43]  > Initializing Localization...
[18:33:43]  > Localization Initialized, for language: en-us!
[18:33:43]  > Initializing Data...
[18:33:44]  > Data 20190628.2 Initialized!
[18:33:44]  > Shortcut for ACT found
[18:33:44]  > Plugin Enabled
[18:33:44]  > Updating Localization for UI...
[18:33:44]  > Localization for UI Updated!
[18:33:44]  > Plugin Started!
[18:33:44]  > Settings Loading...
[18:33:44]  > Language: English
[18:33:44]  > Disable Toasts: False
[18:33:44]  > Make Toasts Persistent: False
[18:33:44]  > Enable Legacy Toasts: False
[18:33:44]  > Enable Text To Speech: False
[18:33:44]  > Enable Test Environment: True
[18:33:44]  > Settings Loaded!
[18:33:44] P: FFXIV Process Selected: 1096
[18:33:44] N: Starting Network Reading...
[18:33:44] N: Detected Game Server Connection: 127.0.0.1:51437 -> 127.0.0.1:9010
[18:33:44] N: Detected Game Server Connection: 192.168.178.21:64571 -> 195.82.50.50:55024
[18:33:44] N: Detected Game Server Connection: 192.168.178.21:64572 -> 195.82.50.50:55024
[18:33:44] N: Started Reading Network Packet
[18:33:44]  > Request Showing Taost received...
[18:33:44]  > ... Legacy Toasts Disabled...
[18:33:44]  > ... Creating new Toast...
[18:33:44]  > ... Toast Showing...
[18:33:44]  > ----------------------------------------------------------------

But the errors are gone.^^

Aiakio commented 5 years ago

Custom version not working.

Forget that. Didnt do a clean install. Custom version is like this:

[19:22:33]  > ----------------------------------------------------------------
[19:22:33]  > Plugin Init
[19:22:33]  > Plugin Version: 1.5.0.0
[19:22:33]  > Initializing Localization...
[19:22:33]  > Localization Initialized, for language: en-us!
[19:22:33]  > Initializing Data...
[19:22:33]  > Data 20190628.2 Initialized!
[19:22:33]  > Shortcut for ACT found
[19:22:33]  > Plugin Enabled
[19:22:33]  > Updating Localization for UI...
[19:22:33]  > Localization for UI Updated!
[19:22:33]  > Plugin Started!
[19:22:33]  > Settings Loading...
[19:22:33]  > Language: English
[19:22:33]  > Disable Toasts: False
[19:22:33]  > Make Toasts Persistent: False
[19:22:33]  > Enable Legacy Toasts: False
[19:22:33]  > Enable Text To Speech: False
[19:22:33]  > Enable Test Environment: True
[19:22:33]  > Settings Loaded!
[19:22:33] P: FFXIV Process Selected: 1096
[19:22:33] N: Starting Network Reading...
[19:22:33] N: Detected Game Server Connection: 192.168.178.21:64571 -> 195.82.50.50:55024
[19:22:33] N: Detected Game Server Connection: 192.168.178.21:64572 -> 195.82.50.50:55024
[19:22:33] N: Detected Game Server Connection: 127.0.0.1:64860 -> 127.0.0.1:9010
[19:22:33] N: Started Reading Network Packet
[19:22:33]  > Request Showing Taost received...
[19:22:33]  > ... Legacy Toasts Disabled...
[19:22:33]  > ... Creating new Toast...
[19:22:33]  > ... Toast Showing...
[19:22:33]  > ----------------------------------------------------------------
[19:22:50] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[19:22:50] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[19:22:50]  > Request Showing Taost received...
[19:22:50]  > ... Legacy Toasts Disabled...
[19:22:50]  > ... Creating new Toast...
[19:22:50]  > ... Toast Showing...
[19:22:50] Q: Matched [651] - the Qitana Ravel
[19:22:53] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[19:22:55] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
[19:22:55] A: Error while analyzing Message: Index (zero based) must be greater than or equal to zero and less than the size of the argument list.

Working but still with errors.

easly1989 commented 5 years ago

Perfect! I'll make an Hot fix for the errors and push it when i get home 😁

Aiakio commented 5 years ago

Whatever you did, @easly1989, the custom version is working without errors now.

You are awesome! :D

easly1989 commented 5 years ago

Happy to hear that! :)

using version 1.5.1 you should be on the same page as the custom one :)

if for any reason you have more troubles on the same matter repon the issue ;)

Aiakio commented 5 years ago

Sorry to reopen. Its not working anymore :(

[18:56:15]  > ----------------------------------------------------------------
[18:56:15]  > Plugin Init
[18:56:15]  > Plugin Version: 1.5.1.0
[18:56:15]  > Initializing Localization...
[18:56:15]  > Localization Initialized, for language: en-us!
[18:56:15]  > Initializing Data...
[18:56:15]  > Data 20190628.2 Initialized!
[18:56:15]  > Shortcut for ACT found
[18:56:15]  > Plugin Enabled
[18:56:15]  > Updating Localization for UI...
[18:56:15]  > Localization for UI Updated!
[18:56:15]  > Plugin Started!
[18:56:15]  > Settings Loading...
[18:56:15]  > Language: English
[18:56:15]  > Disable Toasts: False
[18:56:15]  > Make Toasts Persistent: False
[18:56:15]  > Enable Legacy Toasts: False
[18:56:15]  > Enable Text To Speech: False
[18:56:15]  > Enable Test Environment: True
[18:56:15]  > Settings Loaded!
[18:56:15] P: FFXIV Process Selected: 424
[18:56:15] N: Starting Network Reading...
[18:56:15] N: Detected Game Server Connection: 127.0.0.1:53467 -> 127.0.0.1:9010
[18:56:15] N: Detected Game Server Connection: 127.0.0.1:53474 -> 127.0.0.1:9010
[18:56:15] N: Detected Game Server Connection: 127.0.0.1:53479 -> 127.0.0.1:9010
[18:56:15] N: Detected Game Server Connection: 192.168.178.21:53489 -> 195.82.50.50:55024
[18:56:15] N: Detected Game Server Connection: 192.168.178.21:53490 -> 195.82.50.50:55024
[18:56:15] N: Detected Game Server Connection: 127.0.0.1:53491 -> 127.0.0.1:9010
[18:56:15] N: Detected Game Server Connection: 127.0.0.1:53521 -> 127.0.0.1:9010
[18:56:15] N: Detected Game Server Connection: 127.0.0.1:53532 -> 127.0.0.1:9010
[18:56:15] N: Started Reading Network Packet
[18:56:15]  > Request Showing Taost received...
[18:56:15]  > ... Legacy Toasts Disabled...
[18:56:15]  > ... Creating new Toast...
[18:56:15]  > ... Toast Showing...
[18:56:15]  > ----------------------------------------------------------------

Same for the custom version. I dont know why... This is what i get, even after a few roulettes. DFAssist doesnt recognize dutys anymore again.

easly1989 commented 5 years ago

That is really a strange behavior... Some thinks you can do:

  1. Ensure that FFXIV_ACT_Plugin is the First of your plugins (Top of the list)
  2. Try to disable and re-enable the plugin while the game is already launched (and you are already logged-in, not in the character selection screen, but actually in game)
    • Like this it should work (and thus your problem may be with some misteriously disappeared packet during login?!?)

Let me know what happens!

Aiakio commented 5 years ago
  1. Ensure that FFXIV_ACT_Plugin is the First of your plugins (Top of the list)

It is. Always was.

  1. Try to disable and re-enable the plugin while the game is already launched (and you are already logged-in, not in the character selection screen, but actually in game)
    • Like this it should work (and thus your problem may be with some misteriously disappeared packet during login?!?)

Tried that right now. Not working. I tried every possible order of launching things. First game and wait til im on my character then ACT, first ACT then game, disabled and enabled DFAssist while the game was running and also while it was not. Reinstalled it countless times, tried the custom version from earlier. Nothing. It loads correctly and shows no error messages whatsoever, just doesnt read the duties.

easly1989 commented 5 years ago

Tomorrow I'll try to investigate further... ... this issue is driving me insane >_<...

Anyway, I'm really sorry that it is still not working, will do my best to make it work for you too asap ;)

Aiakio commented 5 years ago

All good. Take your time. :)

easly1989 commented 5 years ago

Ok, I'm doing some tests to understand what is going on. For some reason your log is cluttered with game connections.. and that is really strange.

this is mine: This was obtained starting ACT before launching FFXIV As soon as it find a ffxiv_dx11 process logs

[10:53:14] P: FFXIV Process Selected: 19032 [10:53:14] N: Starting Network Reading...

as soon as it finds the game server logs..

[10:53:14] N: Detected Game Server Connection: 192.168.1.8:59700 -> 195.82.50.9:54994

but while we are in selection screen (or still loading the world) we get this error

[10:53:14] N: Could not find Game Server Connection

to avoid inconsistent loops of connections I added a check in the code for this reason it discards the ffxiv_dx11 process (As it was not able to connect) and tries again from the start

[10:53:44] P: FFXIV Process Selected: 19032 [10:53:44] N: Starting Network Reading... [10:53:44] N: Detected Game Server Connection: 192.168.1.8:59700 -> 195.82.50.9:54994

Another error, as I was still in queue (Ragnarok is heavy populated atm ^^')

[10:53:44] N: Could not find Game Server Connection

so another round...

[10:54:14] P: FFXIV Process Selected: 19032 [10:54:14] N: Starting Network Reading... [10:54:14] N: Detected Game Server Connection: 192.168.1.8:59815 -> 195.82.50.47:55006 [10:54:14] N: Detected Game Server Connection: 192.168.1.8:59816 -> 195.82.50.47:55006

This time we were able to connect to the game server, so the world was loaded

[10:54:14] N: Started Reading Network Packet

Just tried to queue for a dungeon with unsync, to see if everything was working.

[10:54:38] Q: Matching started [Amdapor Keep] [10:54:38] Q: Matching State Updated [Amdapor Keep, 0/1, 0/1, 0/2 | 0] [10:54:38] > Request Showing Taost received... [10:54:38] > ... Toasts are disabled! [10:54:42] Q: Matched [14] - Amdapor Keep [10:54:48] Q: Matching Stopped

So, are you running multiple instances of FF? you have lots of packet... if this is not the case, I may try to discard the "local" packets and see if that helps out

let me know!

Aiakio commented 5 years ago

For some reason your log is cluttered with game connections.. and that is really strange.

Indeed. Sometimes i get like 30 lines of game connections. Its weird, because almost all of them (except 2) are, as you stated, local connections like this: N: Detected Game Server Connection: 127.0.0.1:52346 -> 127.0.0.1:9010

So, are you running multiple instances of FF?

No, im running only one instance xD When i check in Resource Monitor, theres also only one instance of ffxiv_dx11.exe and when i click it, two server connections to the same server ip, like it should be, or like it should show in DFAssist.

easly1989 commented 5 years ago

Okok, I don't know how much it will take to code a packet drop for local packets, Anyway as soon as I have something I'll make another custom build and share it with you for testing (as I still can't reproduce the issue), so it will be a blind fix 😅

Aiakio commented 5 years ago

I may have found something interesting just now: Resource Monitor

The number of IPv4 loopbacks matches the local server connections shown in DFAssist's log: DFAssist Log

If the number of IPv4 loopbacks changes within Resource Monitor, DFAssist doesn't recognize that. Only if i reaload ACT or the plugin that number matches again; always.

EDIT: Why do i even have these IPv4 Loopbacks in the first place?

easly1989 commented 5 years ago

DFAssist_Test.zip

I don't know why you have those loopbacks honestly ^^' Anyway, give this version a try; Instead of the variuos

Detected Game Server Connection: 127.0.0.1:53532 -> 127.0.0.1:9010

you sould see

found local connection... dropping!

if it works, i'll localize the message and make another release!

Aiakio commented 5 years ago

Thanks, just tried it out. It drops the game now, too. xD Also i only had three loopbacks, while testing this, not 28^^

[14:29:34]  > ----------------------------------------------------------------
[14:29:34]  > Plugin Init
[14:29:34]  > Plugin Version: 1.5.5.0
[14:29:34]  > Initializing Localization...
[14:29:34]  > Localization Initialized, for language: en-us!
[14:29:34]  > Initializing Data...
[14:29:35]  > Data 20190628.2 Initialized!
[14:29:35]  > Updating Localization for UI...
[14:29:35]  > Localization for UI Updated!
[14:29:35]  > Shortcut for ACT found
[14:29:35]  > Plugin Enabled
[14:29:35]  > Plugin Started!
[14:29:35]  > Settings Loading...
[14:29:35]  > Language: English
[14:29:35]  > Disable Toasts: False
[14:29:35]  > Make Toasts Persistent: False
[14:29:35]  > Enable Legacy Toasts: False
[14:29:35]  > Enable Text To Speech: False
[14:29:35]  > Enable Test Environment: False
[14:29:35]  > Settings Loaded!
[14:29:35] P: FFXIV Process Selected: 3752
[14:29:35] N: Starting Network Reading...
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35]  > found local connection... dropping!
[14:29:35] N: Could not find Game Server Connection
[14:29:35]  > Request Showing Taost received...
[14:29:35]  > ... Legacy Toasts Disabled...
[14:29:35]  > ... Creating new Toast...
[14:29:35]  > ... Toast Showing...
[14:29:35]  > ----------------------------------------------------------------

I don't know why you have those loopbacks honestly ^^'

So, you dont have them? I thought this was normal... Oh boy.

easly1989 commented 5 years ago

Yep, no loopbacks for me my log from starting ACT (with ff down) until i'm actually in game with my char is like this:

[14:39:47]  > ----------------------------------------------------------------
[14:39:47]  > Plugin Init
[14:39:47]  > Plugin Version: 1.5.5.0
[14:39:47]  > Initializing Localization...
[14:39:48]  > Localization Initialized, for language: en-us!
[14:39:48]  > Initializing Data...
[14:39:48]  > Data 20190628,2 Initialized!
[14:39:48]  > Updating Localization for UI...
[14:39:48]  > Localization for UI Updated!
[14:39:48]  > Shortcut for ACT found
[14:39:48]  > Plugin Enabled
[14:39:48]  > Plugin Started!
[14:39:48]  > Settings Loading...
[14:39:48]  > [DisableToasts] Desired Value: True!
[14:39:48]  > [TTS] Desired Value: True!
[14:39:52]  > Language: English
[14:39:52]  > Disable Toasts: True
[14:39:52]  > Make Toasts Persistent: False
[14:39:52]  > Enable Legacy Toasts: False
[14:39:52]  > Enable Text To Speech: True
[14:39:52]  > Enable Test Environment: False
[14:39:52]  > Settings Loaded!
[14:39:52] P: FFXIV Process Selected: 14320
[14:39:52] N: Starting Network Reading...
[14:39:52] N: Detected Game Server Connection: 192.168.1.8:60516 -> 195.82.50.9:54994
[14:39:52] N: Could not find Game Server Connection
[14:39:52]  > Request Showing Taost received...
[14:39:52]  > ... Toasts are disabled!
[14:39:52]  > ----------------------------------------------------------------
[14:40:22] P: FFXIV Process Selected: 14320
[14:40:22] N: Starting Network Reading...
[14:40:22] N: Detected Game Server Connection: 192.168.1.8:64255 -> 195.82.50.9:54994
[14:40:22] N: Could not find Game Server Connection
[14:40:52] P: FFXIV Process Selected: 14320
[14:40:52] N: Starting Network Reading...
[14:40:52] N: Detected Game Server Connection: 192.168.1.8:64346 -> 195.82.50.47:55006
[14:40:52] N: Detected Game Server Connection: 192.168.1.8:64347 -> 195.82.50.47:55006
[14:40:53] N: Started Reading Network Packet

have you waited a bit to see if the "Starting Network Reading..." appeared again? it may take some time before it comes up again (not longer than 1 minute for sure)

Aiakio commented 5 years ago

Yeah, i waited: just repeated itself with: N: Could not find Game Server Connection. The number of local connections varied with each connection try from DFAssist.

easly1989 commented 5 years ago

Are you using some kind of application to lower ping? like WTFast or similar?

(i know it is a longshot but I'm just searching the web for similar issues at this point ^^')

Aiakio commented 5 years ago

I mentioned a VPN earlier in this thread. That was with ExpressVPN. But im not using it anymore. Its not launched, since my subscription is cancelled for now.

Im not using any network-tool. Not even a internet security. Just windows built in security. Connection is directly through the Telekom Network with nothing changed on those settings. And something like WTFast would probably be worse for my ping than a direct connection, since i already have a very good ping to the european data center.

easly1989 commented 5 years ago

As I have no way to understand what is generating all those loopbacks on your game... I've tried a different route.

So, now all the possible connectioncs are gathered But, i'll try to make the real connection only with the real IPAddress of your machine, thus avoiding the loopbacks. (I noticed a piece of old code I was not caring about that only took care of the first connection received (and in your case it was always a loopback))

tell me if this time we are lucky ... fingers crossed!

AnotherTryBytesTheDust.zip

Aiakio commented 5 years ago

Nice zip-name xD I'll try it as soon as I get home from work.

Might also try to reinstall game or even windows in the next days if necessary.

easly1989 commented 5 years ago

Lol, we'll find a solution without uninstalling the game or windows ;)

Aiakio commented 5 years ago
[...]
[22:09:05] P: FFXIV Process Selected: 16780
[22:09:05] N: Starting Network Reading...
[22:09:05] N: Detected Game Server Connection: 127.0.0.1:50381 -> 127.0.0.1:9010
[22:09:05] N: Detected Game Server Connection: 127.0.0.1:50410 -> 127.0.0.1:9010
[22:09:05] N: Detected Game Server Connection: 127.0.0.1:50422 -> 127.0.0.1:9010
[22:09:05] N: Detected Game Server Connection: 127.0.0.1:50429 -> 127.0.0.1:9010
[22:09:05] N: Detected Game Server Connection: 192.168.178.21:50439 -> 195.82.50.50:55024
[22:09:05] N: Detected Game Server Connection: 192.168.178.21:50440 -> 195.82.50.50:55024
[22:09:05] <LocalEndPoint Found: 192.168.178.21>
[22:09:05] N: Started Reading Network Packet
[22:09:05]  > Request Showing Taost received...
[22:09:05]  > ... Legacy Toasts Disabled...
[22:09:05]  > ... Creating new Toast...
[22:09:05]  > ... Toast Showing...
[22:09:05]  > ----------------------------------------------------------------
[22:09:30] Q: Matching started [Dohn Mheg]
[22:09:30] Q: Matching State Updated [Dohn Mheg, 0/1, 0/1, 0/2 | 0]
[22:09:31]  > Request Showing Taost received...
[22:09:31]  > ... Legacy Toasts Disabled...
[22:09:31]  > ... Creating new Toast...
[22:09:31]  > ... Toast Showing...
[22:09:31] Q: Matched [649] - Dohn Mheg
[22:09:37] Q: Matching State Updated [Dohn Mheg, 0/1, 0/1, 0/2 | 0]
[22:09:37] Q: Entered Instance Area
[22:09:56] Q: Matching Stopped
[22:10:10] Q: Matching started [Holminster Switch]
[22:10:10] Q: Matching State Updated [Holminster Switch, 0/1, 0/1, 0/2 | 0]
[22:10:10]  > Request Showing Taost received...
[22:10:10]  > ... Legacy Toasts Disabled...
[22:10:10]  > ... Creating new Toast...
[22:10:10]  > ... Toast Showing...
[22:10:10] Q: Matched [676] - Holminster Switch
[22:10:12] Q: Matching State Updated [Holminster Switch, 0/1, 0/1, 0/2 | 0]
[22:10:12] Q: Entered Instance Area
[22:10:27] Q: Matching Stopped

Looking good. The local connections are still in there, but i don't mind them as long as its working.

Thank you. You're awesome. Freaking quick fix. Here's to hope, that this time it works longer than a day. :p

easly1989 commented 5 years ago

~~I'll publish the next realease on Tuesday, but only if you don't have any more trouble!~~

I should have waited... but I'm not able to wait.. XD.. Here it is the Latest Release (1.5.5)

It is the exact same as the test build i've sent you, and that was working, so hopefully this will work too.

I'll wait anyone a couple of days before i close the issue (just to be sure :P) Have a nice journey!

Aiakio commented 5 years ago

Just removed the custom version and installed it via ACT directly. So far: working.

Lets assume it will. Otherwise ill report back of course^^ Thank you, @easly1989. You too :)

easly1989 commented 5 years ago

No news, so hopefully you are too busy letting DFAssist tell you your next dungeon :P @Aiakio Gonna close this 💃

Aiakio commented 5 years ago
[10:01:39] Could not find Duty with 0, report to the dev!
[10:01:39] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]
[10:01:43] Could not find Duty with 0, report to the dev!
[10:01:43] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]
[10:02:43] Could not find Duty with 0, report to the dev!
[10:02:43] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]
[10:03:43] Could not find Duty with 0, report to the dev!
[10:03:43] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]
[10:04:43] Could not find Duty with 0, report to the dev!
[10:04:43] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]
[10:05:43] Could not find Duty with 0, report to the dev!
[10:05:43] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]
[10:06:43] Could not find Duty with 0, report to the dev!
[10:06:43] Q: Matching State Updated [Unknown Duty (0), 0/0, 0/0, 0/0 | 0]

Sorry, @easly1989. I'm back once again. :/

Aiakio commented 5 years ago

UPDATE: ACT gave me this error:

---------------------------
Fatal Error - Unhandled Exception
---------------------------
An unhandled exception has occurred.  ACT may close.
Press Ctrl-C to copy this messagebox.

System.IO.IOException: The process cannot access the file 'D:\OneDrive\Documents\My Games\FINAL FANTASY XIV - A Realm Reborn\ACTv3\logs\DFAssist.log' because it is being used by another process.

   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
   at System.IO.FileStream.Init(String path, FileMode mode, FileAccess access, Int32 rights, Boolean useRights, FileShare share, Int32 bufferSize, FileOptions options, SECURITY_ATTRIBUTES secAttrs, String msgPath, Boolean bFromProxy, Boolean useLongPath, Boolean checkHost)
   at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share, Int32 bufferSize, FileOptions options, String msgPath, Boolean bFromProxy, Boolean useLongPath, Boolean checkHost)
   at System.IO.StreamWriter.CreateFile(String path, Boolean append, Boolean checkHost)
   at System.IO.StreamWriter..ctor(String path, Boolean append, Encoding encoding, Int32 bufferSize, Boolean checkHost)
   at System.IO.StreamWriter..ctor(String path, Boolean append)
   at System.IO.FileInfo.AppendText()
   at DFAssist.Core.FileSystemLogger.Write(String message, LogLevel logLevel)
   at DFAssist.Logger.Write(String message, LogLevel logLevel)
   at DFAssist.Helpers.ToastHelper.<.ctor>b__1_0(Int32 code)
---------------------------
OK   
---------------------------

Also, it seems to work again somehow. But still showing both errors after every dungeon queue pop. And then it force closes ACT.

easly1989 commented 5 years ago

Unfortunately i know about this problem, It is issue #16 But i'll not be able to work on a solution until monday!

The workaround is to delete the ACTv3\logs\DFAssist.log before starting ACT

I'll provide an updated (and hopefully fixed) version as soon as i can!

Aiakio commented 5 years ago

Thanks for the quick response and the workaround. Take your time. :)