jalibu/MMM-Jast

No new stock figures after some days

bobbythemoh opened this issue · 5 comments

Platform

Raspbian GNU/Linux 11 (bullseye)

Node.js Version

v16.16.0

MagicMirror Version

2.20.0

Module Version

v2.8.0

Description

Module is working fine for some days - after that the data is not updated any more. Reboot of the Mirror brings back the function. Tried to find entries in the PM2 LOG but it only tells me when the Module was loaded first.

Expected behavior

Data is constantly updated - Entry in mm-out.log "MMM-JAST-Fetcher: Values Updated"

Current behavior

Working for some days after that no updates of stock data - values stay constant without update

Possible solution

No response

Steps to reproduce

Run for some days without reboot - data is not updated any more

Log

pi@MagicMirror:~ $ pm2 log
[TAILING] Tailing last 15 lines for [all] processes (change the value with --lines option)
/home/pi/.pm2/pm2.log last 15 lines:
PM2        | 2022-09-06T20:42:12: PM2 log: PM2 version          : 5.2.0
PM2        | 2022-09-06T20:42:12: PM2 log: Node.js version      : 16.16.0
PM2        | 2022-09-06T20:42:12: PM2 log: Current arch         : arm
PM2        | 2022-09-06T20:42:12: PM2 log: PM2 home             : /home/pi/.pm2
PM2        | 2022-09-06T20:42:12: PM2 log: PM2 PID file         : /home/pi/.pm2/pm2.pid
PM2        | 2022-09-06T20:42:12: PM2 log: RPC socket file      : /home/pi/.pm2/rpc.sock
PM2        | 2022-09-06T20:42:12: PM2 log: BUS socket file      : /home/pi/.pm2/pub.sock
PM2        | 2022-09-06T20:42:12: PM2 log: Application log path : /home/pi/.pm2/logs
PM2        | 2022-09-06T20:42:12: PM2 log: Worker Interval      : 30000
PM2        | 2022-09-06T20:42:12: PM2 log: Process dump file    : /home/pi/.pm2/dump.pm2
PM2        | 2022-09-06T20:42:12: PM2 log: Concurrent actions   : 2
PM2        | 2022-09-06T20:42:12: PM2 log: SIGTERM timeout      : 1600
PM2        | 2022-09-06T20:42:12: PM2 log: ===============================================================================
PM2        | 2022-09-06T20:42:12: PM2 log: App [mm:0] starting in -fork mode-
PM2        | 2022-09-06T20:42:12: PM2 log: App [mm:0] online

/home/pi/.pm2/logs/mm-error.log last 15 lines:
0|mm       | [1320:0906/204253.338629:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
0|mm       | [1373:0906/204253.844766:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.
0|mm       | [1347:0906/204253.936896:ERROR:command_buffer_proxy_impl.cc(126)] ContextResult::kTransientFailure: Failed to send GpuControl.CreateCommandBuffer.

/home/pi/.pm2/logs/mm-out.log:

> magicmirror@2.20.0 start
> DISPLAY="${DISPLAY:=:0}" ./node_modules/.bin/electron js/electron.js

[06.09.2022 20:42.26.458] [LOG]   Starting MagicMirror: v2.20.0
[06.09.2022 20:42.26.476] [LOG]   Loading config ...
[06.09.2022 20:42.26.507] [LOG]   Loading module helpers ...
[06.09.2022 20:42.26.519] [LOG]   No helper found for module: alert.
[06.09.2022 20:42.26.524] [LOG]   No helper found for module: clock.
[06.09.2022 20:42.27.312] [LOG]   Initializing new module helper ...
[06.09.2022 20:42.27.317] [LOG]   Module helper loaded: calendar
[06.09.2022 20:42.27.325] [LOG]   No helper found for module: weather.
[06.09.2022 20:42.27.448] [LOG]   Initializing new module helper ...
[06.09.2022 20:42.27.451] [LOG]   Module helper loaded: newsfeed
[06.09.2022 20:42.27.470] [LOG]   Initializing new module helper ...
[06.09.2022 20:42.27.496] [LOG]   Module helper loaded: MMM-MoonPhase
[06.09.2022 20:42.29.512] [LOG]   Initializing new module helper ...
[06.09.2022 20:42.29.514] [LOG]   Module helper loaded: MMM-Jast
[06.09.2022 20:42.31.334] [LOG]   Initializing new module helper ...
[06.09.2022 20:42.31.336] [LOG]   Check MagicMirror² version for node helper 'MMM-Loxone' - Minimum version: 2.1.1 - Current version: 2.20.0
[06.09.2022 20:42.31.340] [LOG]   Version is ok!
[06.09.2022 20:42.31.341] [LOG]   Module helper loaded: MMM-Loxone
[06.09.2022 20:42.31.344] [LOG]   All module helpers loaded.
[06.09.2022 20:42.43.777] [LOG]   Starting server on port 8080 ... 
[06.09.2022 20:42.43.834] [LOG]   Server started ...
[06.09.2022 20:42.43.838] [LOG]   Connecting socket for: calendar
[06.09.2022 20:42.43.840] [LOG]   Starting node helper for: calendar
[06.09.2022 20:42.43.842] [LOG]   Connecting socket for: newsfeed
[06.09.2022 20:42.43.845] [LOG]   Starting node helper for: newsfeed
[06.09.2022 20:42.43.847] [LOG]   Connecting socket for: MMM-MoonPhase
[06.09.2022 20:42.43.849] [LOG]   Starting module helper: MMM-MoonPhase
[06.09.2022 20:42.43.853] [LOG]   Connecting socket for: MMM-Jast
[06.09.2022 20:42.43.855] [LOG]   MMM-Jast helper method started...
[06.09.2022 20:42.43.877] [LOG]   Connecting socket for: MMM-Loxone
[06.09.2022 20:42.43.883] [LOG]   Sockets connected & modules started ...
[06.09.2022 20:42.45.450] [LOG]   Launching application.
[06.09.2022 20:42.59.378] [LOG]   Create new calendarfetcher for url: http://localhost:8080/modules/calendars/.ics - Interval: 300000
[06.09.2022 20:42.59.421] [LOG]   Create new newsfetcher for url: http://derStandard.at/?page=rss&ressort=Seite1 - Interval: 300000
[06.09.2022 20:42.59.434] [LOG]   Create new newsfetcher for url: https://rss.orf.at/news.xml - Interval: 300000
[06.09.2022 20:43.00.168] [INFO]  Newsfeed-Fetcher: Broadcasting 50 items.
[06.09.2022 20:43.00.784] [INFO]  Calendar-Fetcher: Broadcasting 9 events.
[06.09.2022 20:43.03.755] [INFO]  MMM-Loxone Opening Socket to your Miniserver
[06.09.2022 20:43.05.243] [LOG]   MMM-Loxone Download LoxApp3.json
[06.09.2022 20:43.05.515] [INFO]  Newsfeed-Fetcher: Broadcasting 175 items.
[06.09.2022 20:43.05.710] [INFO]  MMM-Loxone Search room with uuid: 0ea3ebd1-00eb-04ef-ffff390cde3b9b45
[06.09.2022 20:43.05.716] [INFO]  MMM-Loxone Found room: OG Bad
[06.09.2022 20:43.05.719] [INFO]  MMM-Loxone Search IRC for room temperature
[06.09.2022 20:43.05.724] [INFO]  MMM-Loxone Found IRC (Intelligente Raumregelung) in room OG Bad
[06.09.2022 20:43.05.726] [INFO]  MMM-Loxone Check if presenceUuid is defined
[06.09.2022 20:43.05.730] [INFO]  MMM-Loxone Search LightControls and LightV2Controls in room
[06.09.2022 20:43.05.734] [INFO]  MMM-Loxone Found LightControl (Badezimmerlicht) in room OG Bad
[06.09.2022 20:43.05.737] [LOG]   MMM-Loxone observing Uuid (0f1f697f-002c-93d3-ffff390cde3b9b45) is not supported, only VirtualStates or States are supported!
[06.09.2022 20:43.05.739] [INFO]  MMM-Loxone NotificationUuid: 0ea3ebd1-008d-029d-ffff390cde3b9b45
[06.09.2022 20:43.05.741] [INFO]  MMM-Loxone Enabling statusupdates
[06.09.2022 20:43.05.789] [LOG]   MMM-Loxone Successfully executed 'dev/sps/enablebinstatusupdate' with code 200 and value 1
[06.09.2022 20:43.07.001] [INFO]  MMM-Loxone Got room temperature: 23
[06.09.2022 20:43.07.278] [INFO]  MMM-Loxone Got lightMood change to: All off(778)

config.js

{
        module: "MMM-Jast",
        position: "bottom_right",
        config: {
                currencyStyle: "symbol", // One of ["code", "symbol", "name"]
                fadeSpeedInSeconds: 3.5,
                lastUpdateFormat: "HH:mm",
                maxChangeAge: 1 * 24 * 60 * 60 * 1000,
                maxWidth: "100%",
                numberDecimalsPercentages: 1,
                numberDecimalsValues: 2,
                scroll: "none", // One of ["none", "vertical", "horizontal"]
                showColors: true,
                showCurrency: true,
                showChangePercent: true,
                showChangeValue: false,
                showChangeValueCurrency: false,
                showLastUpdate: false,
                showPortfolioValue: false,
                showPortfolioGrowthPercent: false,
                showPortfolioGrowth: false,
                updateIntervalInSeconds: 300,
                useGrouping: false,
                virtualHorizontalMultiplier: 2,
                stocks: [ //https://finance.yahoo.com/
                        { name: "Bitcoin", symbol: "BTC-USD" },
                        { name: "EURO USD", symbol: "EURS-USD" },
                        { name: "ölpreis", symbol: "BZ=F" },
                        //{ name: "S&P500", symbol: "IHPCF" },
                        { name: "PayPal", symbol: "PYPL" },
                        { name: "Linde", symbol: "LIN.DE" },
                        { name: "Amazon.com", symbol: "AMZN" },
                        { name: "Microsoft", symbol: "MSFT" },
                        { name: "NEL", symbol: "D7G.F" },
                        { name: "Walt Disney", symbol: "DIS" },
                        { name: "AMD", symbol: "AMD" },
                        { name: "VERBUND", symbol: "VER.VI" },
                        { name: "Tesla", symbol: "TSLA"}
                ]
        }
},

Additional info

No response

Hi @bobbythemoh,
thank you for your feedback.

Such a bug is not known to me so far. The module has many users and you are the first one who reports that. It's also running stable for me for years. That's strange.

I can only imagine an interference with another module as the cause.
Can you please switch to the test/debugLogging branch? I added some logging statements there for debugging.

git fetch && git checkout test/debugLogging

Thank you for your support

Hi, thanks, I went to Magicmirror/modules/MMM-Jast and executed the command successfully. Guess we need to wait for some days. I will come back with results. What log file do you need then, just regular PM2 Log?

Hi, i was able to reproduce the conditition, so it took approx. 7 days till it was stuck. i had a look in pm2 log, i only can see the starting of the module in logging "Module helper loaded: MMM-Jast".

Hi, i was able to reproduce the conditition, so it took approx. 7 days till it was stuck. i had a look in pm2 log, i only can see the starting of the module in logging "Module helper loaded: MMM-Jast".

@bobbythemoh if this is the only log message, I doubt that you are on the right branch. There should be a log entry for each request (so at least every few minutes).

Please double check if you are on the right branch (e.g. with git status)

I will close now. Feel free to reopen if you have new helpful information