calcu

calcu

@sdetweil Well… we are here again:

npm run start errors:

[03.04.2021 21:46.00.432] [ERROR] (node:2588) UnhandledPromiseRejectionWarning: Error: invalid_grant
    at createError (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/core/createError.js:16:15)
    at settle (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/core/settle.js:18:12)
    at IncomingMessage.handleStreamEnd (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/adapters/http.js:202:11)
    at IncomingMessage.emit (events.js:327:22)
    at endReadableNT (_stream_readable.js:1220:12)
    at processTicksAndRejections (internal/process/task_queues.js:84:21)
[03.04.2021 21:46.00.435] [ERROR] (node:2588) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2)
[03.04.2021 21:46.00.439] [ERROR] (node:2588) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code.
[03.04.2021 21:47.03.919] [ERROR] (node:2588) UnhandledPromiseRejectionWarning: Error: invalid_grant
    at createError (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/core/createError.js:16:15)
    at settle (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/core/settle.js:18:12)
    at IncomingMessage.handleStreamEnd (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/adapters/http.js:202:11)
    at IncomingMessage.emit (events.js:327:22)
    at endReadableNT (_stream_readable.js:1220:12)
    at processTicksAndRejections (internal/process/task_queues.js:84:21)
[03.04.2021 21:47.03.922] [ERROR] (node:2588) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 4)
[03.04.2021 21:47.59.391] [ERROR] (node:2588) UnhandledPromiseRejectionWarning: Error: invalid_grant
    at createError (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/core/createError.js:16:15)
    at settle (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/core/settle.js:18:12)
    at IncomingMessage.handleStreamEnd (/home/pi/MagicMirror/modules/MMM-GooglePhotos/node_modules/google-auth-library/node_modules/axios/lib/adapters/http.js:202:11)
    at IncomingMessage.emit (events.js:327:22)
    at endReadableNT (_stream_readable.js:1220:12)
    at processTicksAndRejections (internal/process/task_queues.js:84:21)
[03.04.2021 21:47.59.392] [ERROR] (node:2588) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 6)

developers window:

Load script: modules/MMM-GoogleAssistant/MMM-GoogleAssistant.js  module.js:508
Check MagicMirror version for module 'MMM-GoogleAssistant' - Minimum version:  2.14.0 - Current version: 2.15.0 module.js:516 
Module registered: MMM-GoogleAssistant loader.js:157 
Bootstrapping module: MMM-GoogleAssistant  loader.js:185
Load script: /modules/MMM-GoogleAssistant/components/response.js loader.js:162
Scripts loaded for: MMM-GoogleAssistant   loader.js:204 
Load stylesheet: /modules/MMM-GoogleAssistant/MMM-GoogleAssistant.css loader.js:164 
Styles loaded for: MMM-GoogleAssistant translator.js:107 
MMM-GoogleAssistant - Load translation fallback: translations/en.json loader.js:166 
Translations loaded for: MMM-GoogleAssistant 
MMM-Assistant2Display.js:687 
[A2D] Found: GoogleAssistant loader.js:185 
Load script: modules/MMM-GooglePhotos/MMM-GooglePhotos.js  module.js:516 
Module registered: MMM-GooglePhotos  loader.js:157 
Bootstrapping module: MMM-GooglePhotos  loader.js:162
 Scripts loaded for: MMM-GooglePhotos  loader.js:204 
Load stylesheet: modules/MMM-GooglePhotos/MMM-GooglePhotos.css  loader.js:164 
Styles loaded for: MMM-GooglePhotos  loader.js:166 
Translations loaded for: MMM-GooglePhotos  module.js:199
MMM-GoogleAssistant is suspended.   module.js:199
 MMM-GooglePhotos is suspended.   main.js:297 
Will not show MMM-GoogleAssistant. LockStrings active: GA_LOCKED  main.js:297

I will create a new token

Edit:

Just deleted token.js, and did again “node generate_token.js”, pasted the code, and everything works again

calcu

@sdetweil i will check when it will go crazy again with the photos speed, and i will repeat this logs again

calcu

@sdetweil Hi,
I don’t use pm2 because i use RTSPStream module and it doesn’t work with pm2.

Then, i started the MagicMirror with “npm run start”, the log is this:

pi@MagicMirror:~ $ cd MagicMirror/
pi@MagicMirror:~/MagicMirror $ npm run start

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

[28.03.2021 12:28.28.143] [LOG]   Starting MagicMirror: v2.14.0
[28.03.2021 12:28.28.149] [LOG]   Loading config ...
[28.03.2021 12:28.28.155] [LOG]   Loading module helpers ...
[28.03.2021 12:28.28.158] [LOG]   No helper found for module: MMM-pages.
[28.03.2021 12:28.28.159] [LOG]   No helper found for module: MMM-page-indicator.
[28.03.2021 12:28.28.184] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.28.185] [LOG]   Module helper loaded: MMM-Traffic
[28.03.2021 12:28.30.092] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.30.094] [LOG]   Module helper loaded: MMM-GoogleAssistant
[28.03.2021 12:28.31.319] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.31.320] [LOG]   Module helper loaded: MMM-Assistant2Display
[28.03.2021 12:28.31.716] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.31.717] [LOG]   Module helper loaded: MMM-UpdateNotification
[28.03.2021 12:28.31.721] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.31.722] [LOG]   Module helper loaded: MMM-GroveGestures
[28.03.2021 12:28.32.404] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.32.404] [LOG]   Module helper loaded: MMM-RTSPStream
[28.03.2021 12:28.32.675] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.32.676] [LOG]   Module helper loaded: MMM-iFrame-Ping
[28.03.2021 12:28.32.677] [LOG]   No helper found for module: alert.
[28.03.2021 12:28.32.677] [LOG]   No helper found for module: clock.
[28.03.2021 12:28.32.764] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.32.765] [LOG]   Module helper loaded: calendar
[28.03.2021 12:28.32.766] [LOG]   No helper found for module: currentweather.
[28.03.2021 12:28.32.767] [LOG]   No helper found for module: weatherforecast.
[28.03.2021 12:28.32.788] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.32.789] [LOG]   Module helper loaded: newsfeed
[28.03.2021 12:28.32.801] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.32.802] [LOG]   Module helper loaded: MMM-SystemStats
[28.03.2021 12:28.32.883] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.32.884] [LOG]   Module helper loaded: MMM-NetworkConnection
[28.03.2021 12:28.33.084] [LOG]   Initializing new module helper ...
[28.03.2021 12:28.33.085] [LOG]   Module helper loaded: MMM-GooglePhotos
[28.03.2021 12:28.33.086] [LOG]   No helper found for module: MMM-Cursor.
[28.03.2021 12:28.33.086] [LOG]   All module helpers loaded.
[28.03.2021 12:28.33.154] [LOG]   Starting server on port 8080 ... 
[28.03.2021 12:28.33.157] [WARN]  You're using a full whitelist configuration to allow for all IPs
[28.03.2021 12:28.33.164] [LOG]   Server started ...
[28.03.2021 12:28.33.165] [LOG]   Connecting socket for: MMM-Traffic
[28.03.2021 12:28.33.166] [LOG]   MMM-Traffic helper started ...
[28.03.2021 12:28.33.167] [LOG]   Connecting socket for: MMM-GoogleAssistant
[28.03.2021 12:28.33.167] [LOG]   Connecting socket for: MMM-Assistant2Display
[28.03.2021 12:28.33.168] [LOG]   Connecting socket for: MMM-UpdateNotification
[28.03.2021 12:28.33.170] [LOG]   [UN] MMM-UpdateNotification Version: 1.2.2
[28.03.2021 12:28.33.172] [LOG]   [UN] MagicMirror is running on pid: 31904
[28.03.2021 12:28.33.173] [LOG]   Connecting socket for: MMM-GroveGestures
[28.03.2021 12:28.33.174] [LOG]   Connecting socket for: MMM-RTSPStream
[28.03.2021 12:28.33.175] [LOG]   PM2: Stopping all OMXPlayer Streams...
[28.03.2021 12:28.33.180] [LOG]   Connecting socket for: MMM-iFrame-Ping
[28.03.2021 12:28.33.181] [LOG]   MMM-iFrame-Ping helper started ...
[28.03.2021 12:28.33.183] [LOG]   Connecting socket for: calendar
[28.03.2021 12:28.33.184] [LOG]   Starting node helper for: calendar
[28.03.2021 12:28.33.185] [LOG]   Connecting socket for: newsfeed
[28.03.2021 12:28.33.186] [LOG]   Starting node helper for: newsfeed
[28.03.2021 12:28.33.188] [LOG]   Connecting socket for: MMM-SystemStats
[28.03.2021 12:28.33.189] [LOG]   Connecting socket for: MMM-NetworkConnection
[28.03.2021 12:28.33.190] [LOG]   MMM-NetworkConnection helper started ...
[28.03.2021 12:28.33.191] [LOG]   Connecting socket for: MMM-GooglePhotos
[28.03.2021 12:28.33.193] [LOG]   Sockets connected & modules started ...
[28.03.2021 12:28.33.707] [LOG]   Launching application.
[28.03.2021 12:28.33.807] [WARN]  (electron) The default value of app.allowRendererProcessReuse is deprecated, it is currently "false".  It will change to be "true" in Electron 9.  For more information please check https://github.com/electron/electron/issues/18397
[28.03.2021 12:28.34.264] [ERROR] Whoops! There was an uncaught exception...
[28.03.2021 12:28.34.271] [ERROR] TypeError: Cannot convert undefined or null to object
    at Function.keys (<anonymous>)
    at stopProcs (/home/pi/MagicMirror/modules/MMM-RTSPStream/node_helper.js:458:32)
    at /home/pi/MagicMirror/modules/MMM-RTSPStream/node_helper.js:487:17
    at /home/pi/MagicMirror/modules/MMM-RTSPStream/node_modules/pm2/lib/API.js:606:19
    at /home/pi/MagicMirror/modules/MMM-RTSPStream/node_modules/pm2-axon-rpc/lib/client.js:45:10
    at Parser.<anonymous> (/home/pi/MagicMirror/modules/MMM-RTSPStream/node_modules/pm2-axon/lib/sockets/req.js:67:8)
    at Parser.emit (events.js:210:5)
    at Parser._write (/home/pi/MagicMirror/modules/MMM-RTSPStream/node_modules/amp/lib/stream.js:91:16)
    at doWrite (_stream_writable.js:431:12)
    at writeOrBuffer (_stream_writable.js:415:5)
    at Parser.Writable.write (_stream_writable.js:305:11)
    at Socket.ondata (_stream_readable.js:726:22)
    at Socket.emit (events.js:210:5)
    at addChunk (_stream_readable.js:308:12)
    at readableAddChunk (_stream_readable.js:289:11)
    at Socket.Readable.push (_stream_readable.js:223:10)
[28.03.2021 12:28.34.274] [ERROR] MagicMirror will not quit, but it might be a good idea to check why this happened. Maybe no internet connection?
[28.03.2021 12:28.34.275] [ERROR] If you think this really is an issue, please open an issue on GitHub: https://github.com/MichMich/MagicMirror/issues
[28.03.2021 12:28.37.226] [LOG]   Create new calendar fetcher for url: https://calendar.google.com/xxxx381/basic.ics - Interval: 300000
[28.03.2021 12:28.37.237] [LOG]   Create new calendar fetcher for url: https://calendar.google.com/calendar/ical/es.spain%23holiday%40group.v.calendar.google.com/public/basic.ics - Interval: 300000
[28.03.2021 12:28.37.244] [LOG]   Create new news fetcher for url: https://www.elperiodico.com/es/rss/rss_portada.xml - Interval: 300000
[28.03.2021 12:28.37.287] [LOG]   Create new news fetcher for url: https://www.elperiodico.com/es/rss/sabadell/rss.xml - Interval: 300000
[28.03.2021 12:28.37.291] [LOG]   Create new news fetcher for url: https://www.elperiodico.com/es/rss/internacional/rss.xml - Interval: 300000
[28.03.2021 12:28.37.294] [LOG]   Create new news fetcher for url: https://www.elperiodico.com/es/rss/ciencia/rss.xml - Interval: 300000
[28.03.2021 12:28.37.506] [LOG]   [GA] MMM-GoogleAssistant Version: 2.5.3
[28.03.2021 12:28.37.513] [LOG]   [GA] RECIPE_LOADED: with-BackgroundStatus.js
[28.03.2021 12:28.37.514] [LOG]   [GA] Assistant2Display Server Started
[28.03.2021 12:28.37.517] [LOG]   [NPM] Initialized v0.9.93
[28.03.2021 12:28.37.605] [LOG]   [GA] Google Assistant is initialized.
[28.03.2021 12:28.37.607] [LOG]   [A2D] MMM-Assistant2Display Version: 2.5.0
[28.03.2021 12:28.37.609] [LOG]   [CAST] Cast v1.1.0 Initialized...
[28.03.2021 12:28.37.616] [LOG]   [A2D] Assistant2Display is initialized.
[28.03.2021 12:28.38.704] [INFO]  Newsfeed-Fetcher: Broadcasting 50 items.
[28.03.2021 12:28.38.910] [INFO]  Newsfeed-Fetcher: Broadcasting 50 items.
[28.03.2021 12:28.39.060] [INFO]  Newsfeed-Fetcher: Broadcasting 50 items.
[28.03.2021 12:28.39.376] [INFO]  Newsfeed-Fetcher: Broadcasting 49 items.
[28.03.2021 12:28.39.475] [LOG]   Starting stream stream1 using VLC with args --width 950 --height 540 -I dummy --video-on-top --no-video-deco --no-embedded-video --video-title=stream1 rtsp://admin:xxx@192.168.1.107:554/cam/realmonitor?channel=1&subtype=1...
[28.03.2021 12:28.39.512] [LOG]   Starting stream stream2 using VLC with args --width 960 --height 540 -I dummy --video-on-top --no-video-deco --no-embedded-video --video-title=stream2 rtsp://192.168.1.113:554/user=admin_password=xxxx_channel=0_stream=0.sdp?real_stream...
[28.03.2021 12:28.39.754] [LOG]   starting network connection testing
[28.03.2021 12:28.39.860] [LOG]   DP2: Config File Saved!
[28.03.2021 12:28.39.870] [INFO]  DP2: Running window resizers...
[28.03.2021 12:28.40.123] [INFO]  Calendar-Fetcher: Broadcasting 3 events.
[28.03.2021 12:28.40.565] [INFO]  Calendar-Fetcher: Broadcasting 10 events.
[28.03.2021 12:28.53.918] [INFO]  DP2: Running window resizers...
[28.03.2021 12:28.58.006] [ERROR] exec error: Error: Command failed: wmctrl -r stream2 -b add,hidden

[28.03.2021 12:29.02.863] [LOG]   Stopping stream stream2
[28.03.2021 12:29.03.290] [LOG]   Delayed exit of all VLC Streams in 5 sec...
[28.03.2021 12:29.06.023] [LOG]   Delayed exit of all VLC Streams in 5 sec...
[28.03.2021 12:29.08.293] [LOG]   Stopping stream stream1

The errors from RTSPStream are normal, some day i will check them (but now everything works).

and the code from the console table is:

loader.js:176 Load script: modules/MMM-GoogleAssistant//MMM-GoogleAssistant.js
module.js:509 Check MagicMirror version for module 'MMM-GoogleAssistant' - Minimum version:  2.14.0 - Current version: 2.14.0
module.js:517 Module registered: MMM-GoogleAssistant
loader.js:148 Bootstrapping module: MMM-GoogleAssistant
loader.js:176 Load script: /modules/MMM-GoogleAssistant/components/response.js
loader.js:153 Scripts loaded for: MMM-GoogleAssistant
loader.js:195 Load stylesheet: /modules/MMM-GoogleAssistant/MMM-GoogleAssistant.css
loader.js:155 Styles loaded for: MMM-GoogleAssistant
translator.js:110 MMM-GoogleAssistant - Load translation fallback: translations/en.json
security-warnings.ts:125 Electron Security Warning (Insecure Resources) This renderer process loads resources using insecure
  protocols. This exposes users of this app to unnecessary security risks.
  Consider loading the following resources over HTTPS or FTPS. 
- http://0.0.0.0:8080/css/main.css
- http://0.0.0.0:8080/fonts/roboto.css
- http://0.0.0.0:8080/socket.io/socket.io.js
- http://0.0.0.0:8080/vendor/node_modules/nunjucks/browser/nunjucks.min.js
- http://0.0.0.0:8080/js/defaults.js
- http://0.0.0.0:8080/config/config.js
- http://0.0.0.0:8080/vendor/vendor.js
- http://0.0.0.0:8080/modules/default/defaultmodules.js
- http://0.0.0.0:8080/js/logger.js
- http://0.0.0.0:8080/translations/translations.js
- http://0.0.0.0:8080/js/translator.js
- http://0.0.0.0:8080/js/class.js
- http://0.0.0.0:8080/js/module.js
- http://0.0.0.0:8080/js/loader.js
- http://0.0.0.0:8080/js/socketclient.js
- http://0.0.0.0:8080/js/main.js
- http://0.0.0.0:8080/fonts/node_modules/roboto-fontface/fonts/roboto-condensed/Roboto-Condensed-Regular.woff2
- http://0.0.0.0:8080/translations/es.json
- http://0.0.0.0:8080/translations/en.json
- http://0.0.0.0:8080/modules/MMM-pages//MMM-pages.js
- http://0.0.0.0:8080/modules/MMM-pages/pages.css
- http://0.0.0.0:8080/modules/MMM-page-indicator//MMM-page-indicator.js
- http://0.0.0.0:8080/vendor/css/font-awesome.css
- http://0.0.0.0:8080/vendor/node_modules/@fortawesome/fontawesome-free/css/all.min.css
- http://0.0.0.0:8080/vendor/node_modules/@fortawesome/fontawesome-free/css/v4-shims.min.css
- http://0.0.0.0:8080/modules/MMM-page-indicator/page-indicators.css
- http://0.0.0.0:8080/modules/MMM-Traffic//MMM-Traffic.js
- http://0.0.0.0:8080/vendor/node_modules/moment/min/moment-with-locales.js
- http://0.0.0.0:8080/modules/MMM-Traffic/traffic.css
- http://0.0.0.0:8080/modules/MMM-GoogleAssistant//MMM-GoogleAssistant.js
- http://0.0.0.0:8080/modules/MMM-GoogleAssistant/components/response.js
- http://0.0.0.0:8080/modules/MMM-GoogleAssistant/MMM-GoogleAssistant.css
  

For more information and help, consult
https://electronjs.org/docs/tutorial/security.
This warning will not show up
once the app is packaged.
warnAboutInsecureResources @ security-warnings.ts:125
loader.js:157 Translations loaded for: MMM-GoogleAssistant
MMM-Assistant2Display.js:1 [A2D] Found: GoogleAssistant
loader.js:176 Load script: modules/MMM-GooglePhotos//MMM-GooglePhotos.js
module.js:517 Module registered: MMM-GooglePhotos
loader.js:148 Bootstrapping module: MMM-GooglePhotos
loader.js:153 Scripts loaded for: MMM-GooglePhotos
loader.js:195 Load stylesheet: modules/MMM-GooglePhotos/MMM-GooglePhotos.css
loader.js:155 Styles loaded for: MMM-GooglePhotos
loader.js:157 Translations loaded for: MMM-GooglePhotos
MMM-GooglePhotos.js:192 updated!
module.js:199 MMM-GoogleAssistant is suspended.
module.js:199 MMM-GooglePhotos is suspended.
main.js:297 Will not show MMM-GoogleAssistant. LockStrings active: GA_LOCKED
MMM-GooglePhotos.js:165 [GPHOTO] Image loaded: https://lh3.googleusercontent.com/lr/AFxxRLGJxfZg=w1920-h1080
main.js:297 Will not show MMM-GoogleAssistant. LockStrings active: GA_LOCKED
module.js:206 MMM-GooglePhotos is resumed.
module.js:199 MMM-GooglePhotos is suspended.
main.js:297 Will not show MMM-GoogleAssistant. LockStrings active: GA_LOCKED
main.js:297 Will not show MMM-GoogleAssistant. LockStrings active: GA_LOCKED
module.js:206 MMM-GooglePhotos is resumed.

calcu

@megagprime hi,

Maybe I have the same problem… I saw it was working fine for some time, but suddenly the transition speed of the fotos was a … 5/6 photos each second. But I don’t know why…

Then, the token of google reached it’s maximum of petitions and then… Stopped working.

I had to re do the token, and everything works fine again.

Maybe it’s related ?

calcu

@calcu

Latest posts made by calcu