SteveTownsend/PauseAfterLoadUnscripted

Loading Menu closed after preceding Opened event - pause OK (yet no pause)

Closed this issue · 8 comments

2022-01-04 16:23:24.331     info   1784 Plugin Data load complete!
2022-01-04 16:23:24.331     info   1784 Initialized Data, Pause available
2022-01-04 16:23:24.723     info   1756 Loading Menu closed without preceding Opened event - no pause
2022-01-04 16:23:26.324     info   1568 kPreLoadGame message
2022-01-04 16:23:26.399     info   1568 Loading Menu opened
2022-01-04 16:23:33.776     info   1568 kPostLoadGame message
2022-01-04 16:23:33.825     info   1568 Loading Menu closed after preceding Opened event - pause OK
2022-01-04 16:23:40.366     info   1568 kPreLoadGame message
2022-01-04 16:23:40.368     info   1568 Loading Menu opened
2022-01-04 16:23:42.557     info   1568 kPostLoadGame message
2022-01-04 16:23:42.559     info   1568 Loading Menu closed after preceding Opened event - pause OK
2022-01-04 16:23:54.802     info   1568 kPreLoadGame message
2022-01-04 16:23:54.804     info   1568 Loading Menu opened
2022-01-04 16:23:57.028     info   1568 kPostLoadGame message
2022-01-04 16:23:57.031     info   1568 Loading Menu closed after preceding Opened event - pause OK
2022-01-04 16:24:21.778     info   1568 kPreLoadGame message
2022-01-04 16:24:21.780     info   1568 Loading Menu opened
2022-01-04 16:24:24.796     info   1568 kPostLoadGame message
2022-01-04 16:24:24.801     info   1568 Loading Menu closed after preceding Opened event - pause OK
2022-01-04 16:24:42.602     info   1568 kPreLoadGame message
2022-01-04 16:24:42.604     info   1568 Loading Menu opened
2022-01-04 16:24:44.903     info   1568 kPostLoadGame message
2022-01-04 16:24:44.906     info   1568 Loading Menu closed after preceding Opened event - pause OK

log from 1.0.0.6

this didn't happen in 1.0.0.4 (don't know about .5)
it used to say sgtm .001 or so

I suspect this is to do with Magic Effects again but need the log to confirm

objir commented

A log here:

2022-01-05 01:28:38.480 info 18884 PauseAfterLoadUnscripted v1.0.0.6
2022-01-05 01:28:38.480 info 18884 GetGamePath result: E:\Steam\steamapps\common\Skyrim Special Edition
2022-01-05 01:28:38.480 info 18884 Refresh settings cache from valid file E:\Steam\steamapps\common\Skyrim Special Edition\Data\SKSE\Plugins\PauseAfterLoadUnscripted.ini
2022-01-05 01:28:38.480 trace 18884 ResumeAfter = 60.0 seconds
2022-01-05 01:28:38.480 trace 18884 CanUnpauseAfter = 0.0 seconds
2022-01-05 01:28:38.480 trace 18884 PauseOnSave = false
2022-01-05 01:28:38.480 trace 18884 PausedSGTM = 0.001
2022-01-05 01:28:38.480 trace 18884 NormalSGTM = 1.000
2022-01-05 01:28:38.480 trace 18884 IgnoreKeyPressAndButton = true
2022-01-05 01:28:38.480 trace 18884 IgnoreMouseMove = true
2022-01-05 01:28:38.480 trace 18884 IgnoreThumbstick = true
2022-01-05 01:28:38.480 info 18884 PauseAfterLoadUnscripted plugin loaded
2022-01-05 01:28:40.385 info 18884 kPostLoad message
2022-01-05 01:28:40.385 info 18884 kPostPostLoad message
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Slow Time Effect(00048acd)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Slow Time Effect(020068b7)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Supernatural Reflexes(0201a30d)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Frostmoon Instinct(04035b1c)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Gods and Mortals(8006fccd)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Slow Time(8007b100)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Death in Three Acts(8008d4bd)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Death Blossom(8008d4ca)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Leaping Shadow(8008d4d0)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Massacre(8009c823)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Hurricane(800be569)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Wicked Wind(800bfb15)
2022-01-05 01:29:07.177 trace 4488 SlowTime Magic Effect : Laughing Ghost(800c0085)
2022-01-05 01:29:07.178 trace 4488 SlowTime Magic Effect : Hawkeye(800d23e5)
2022-01-05 01:29:07.178 trace 4488 SlowTime Magic Effect : Massacre(8013251d)
2022-01-05 01:29:07.178 trace 4488 SlowTime Magic Effect : StopTimeFX(b137c356)
2022-01-05 01:29:07.178 info 4488 Plugin Data load complete!
2022-01-05 01:29:07.178 info 4488 Initialized Data, Pause available
2022-01-05 01:29:07.882 info 18884 Loading Menu closed without preceding Opened event - no pause
2022-01-05 01:29:21.244 info 18884 kPreLoadGame message
2022-01-05 01:29:21.246 info 18884 kPostLoadGame message
2022-01-05 01:29:21.507 info 18884 kPreLoadGame message
2022-01-05 01:29:21.526 info 18884 Loading Menu opened
2022-01-05 01:29:38.016 info 18884 kPostLoadGame message
2022-01-05 01:29:38.023 info 18884 Loading Menu closed after preceding Opened event - pause OK
2022-01-05 01:29:38.023 debug 18884 Player subject to non-constant-cast SlowTime or ValueModifier-BowSpeedBonus archetype effect : StopTimeFX(b137c356)
2022-01-05 01:29:55.639 info 18884 Loading Menu opened
2022-01-05 01:30:00.103 info 18884 Loading Menu closed after preceding Opened event - pause OK
2022-01-05 01:30:00.103 debug 18884 Player subject to non-constant-cast SlowTime or ValueModifier-BowSpeedBonus archetype effect : StopTimeFX(b137c356)

Thanks for the update for logging. StopTimeFX(b137c356) is from nether's follower framework. It is inactive on my character.

objir commented

A pic for StopTimeFX(b137c356) in more info console: https://i.imgur.com/skN5WHR.png

This effect will only be active when the in-game follower command menu is opened.

Edit: Yes I managed to remove it from my character and the pause finally worked. So looks like it is not Excluded as it should be?

manually setting sgtm in the in-game console works

these are the effects that were in the log:

2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time Effect(000d8c32)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time Effect(00048acd)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time Effect(020068b7)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Supernatural Reflexes(0201a30d)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Frostmoon Instinct(04035b1c)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time(7648da58)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Vampire Slow Time Effect(7705d262)

manually setting sgtm in the in-game console works

these are the effects that were in the log:

2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time Effect(000d8c32)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time Effect(00048acd)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time Effect(020068b7)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Supernatural Reflexes(0201a30d)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Frostmoon Instinct(04035b1c)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Slow Time(7648da58)
2022-01-04 16:23:24.331    trace   1784 SlowTime Magic Effect : Vampire Slow Time Effect(7705d262)

Without a full log I cannot do anything about this

A pic for StopTimeFX(b137c356) in more info console: https://i.imgur.com/skN5WHR.png

This effect will only be active when the in-game follower command menu is opened.

Edit: Yes I managed to remove it from my character and the pause finally worked. So looks like it is not Excluded as it should be?

I tracked down some logic that checks for Inactive/Active MGEF properly, I'll try this.

The NFF MGEF is now properly skipped when Inactive. Releasing for v1.0.0.7

2022-01-04 18:09:12.812     info  23092 Loading Menu opened
2022-01-04 18:09:31.242     info  23092 kPostLoadGame message
2022-01-04 18:10:07.272     info  23092 Loading Menu closed after preceding Opened event - pause OK
2022-01-04 18:10:07.272    debug  23092 Skip Inactive SlowTime or ValueModifier-BowSpeedBonus archetype effect : StopTimeFX(ea37c356)
2022-01-04 18:10:07.272     info  23092 OK to pause
2022-01-04 18:10:07.274    debug  23092 Ran Console command sgtm 0.001
2022-01-04 18:10:07.274    debug  23092 Resume game if no input for 3.0 seconds, ignoring input for 0.0 seconds
2022-01-04 18:10:07.274    debug  19272 Starting timer thread
2022-01-04 18:10:07.284     info  48420 Pause terminated by Input Event type 0
2022-01-04 18:10:07.284    debug  48420 Cancel active pause timer
2022-01-04 18:10:07.284    debug  19272 Exiting timer thread
2022-01-04 18:10:07.284    debug  48420 Ran Console command sgtm 1.000