v2.18.0 update gave black screen, then nothing.

Richard238

It’s still throwing the log.log error!

pi@magicmirror:~/MagicMirror $ npm start

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

App threw an error during load
TypeError: Log.log is not a function
    at Object.<anonymous> (/home/pi/MagicMirror/js/app.js:20:5)
    at Module._compile (node:internal/modules/cjs/loader:1116:14)
    at Object.Module._extensions..js (node:internal/modules/cjs/loader:1169:10)
    at Module.load (node:internal/modules/cjs/loader:988:32)
    at Module._load (node:internal/modules/cjs/loader:829:12)
    at Function.c._load (node:electron/js2c/asar_bundle:5:13331)
    at Module.require (node:internal/modules/cjs/loader:1012:19)
    at require (node:internal/modules/cjs/helpers:94:18)
    at Object.<anonymous> (/home/pi/MagicMirror/js/electron.js:4:14)
    at Module._compile (node:internal/modules/cjs/loader:1116:14)
(node:6752) [DEP0025] DeprecationWarning: sys is deprecated. Use util instead.
(Use `electron --trace-deprecation ...` to show where the warning was created)
A JavaScript error occurred in the main process
Uncaught Exception:
TypeError: Log.log is not a function
    at Object.<anonymous> (/home/pi/MagicMirror/js/app.js:20:5)
    at Module._compile (node:internal/modules/cjs/loader:1116:14)
    at Object.Module._extensions..js (node:internal/modules/cjs/loader:1169:10)
    at Module.load (node:internal/modules/cjs/loader:988:32)
    at Module._load (node:internal/modules/cjs/loader:829:12)
    at Function.c._load (node:electron/js2c/asar_bundle:5:13331)
    at Module.require (node:internal/modules/cjs/loader:1012:19)
    at require (node:internal/modules/cjs/helpers:94:18)
    at Object.<anonymous> (/home/pi/MagicMirror/js/electron.js:4:14)
    at Module._compile (node:internal/modules/cjs/loader:1116:14)
[6808:0106/162138.316545:ERROR:viz_main_impl.cc(161)] Exiting GPU process due to errors during initialization
[6828:0106/162138.716857:ERROR:sandbox_linux.cc(376)] InitializeSandbox() called with multiple threads in process gpu-process.

sdetweil

@richard238 ok, fun times…

so, do

cd ~
mv MagicMirror MagicMirror.save
git clone  https://github.com/MichMich/MagicMirror.git
cd MagicMirror
npm install --only=prod
cd config
cp config.js.sample config.js
cd ..

then npm start

Richard238

@sdetweil

Clean install - works perfectly! :)

pi@magicmirror:~/MagicMirror $ cd config
pi@magicmirror:~/MagicMirror/config $ cp config.js.sample config.js
pi@magicmirror:~/MagicMirror/config $ cd ..
pi@magicmirror:~/MagicMirror $ npm start

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

[06.01.2022 16:30.01.197] [LOG]   Starting MagicMirror: v2.18.0
[06.01.2022 16:30.01.222] [LOG]   Loading config ...
[06.01.2022 16:30.01.238] [LOG]   Loading module helpers ...
[06.01.2022 16:30.01.243] [LOG]   No helper found for module: alert.
[06.01.2022 16:30.01.307] [LOG]   Initializing new module helper ...
[06.01.2022 16:30.01.311] [LOG]   Module helper loaded: updatenotification
[06.01.2022 16:30.01.315] [LOG]   No helper found for module: clock.
[06.01.2022 16:30.01.765] [LOG]   Initializing new module helper ...
[06.01.2022 16:30.01.768] [LOG]   Module helper loaded: calendar
[06.01.2022 16:30.01.771] [LOG]   No helper found for module: compliments.
[06.01.2022 16:30.01.773] [LOG]   No helper found for module: weather.
[06.01.2022 16:30.01.843] [LOG]   Initializing new module helper ...
[06.01.2022 16:30.01.845] [LOG]   Module helper loaded: newsfeed
[06.01.2022 16:30.01.848] [LOG]   All module helpers loaded.
[06.01.2022 16:30.02.152] [LOG]   Starting server on port 8080 ... 
[06.01.2022 16:30.02.183] [LOG]   Server started ...
[06.01.2022 16:30.02.185] [LOG]   Connecting socket for: updatenotification
[06.01.2022 16:30.02.187] [LOG]   Starting module helper: updatenotification
[06.01.2022 16:30.02.189] [LOG]   Connecting socket for: calendar
[06.01.2022 16:30.02.190] [LOG]   Starting node helper for: calendar
[06.01.2022 16:30.02.191] [LOG]   Connecting socket for: newsfeed
[06.01.2022 16:30.02.192] [LOG]   Starting node helper for: newsfeed
[06.01.2022 16:30.02.193] [LOG]   Sockets connected & modules started ...
[06.01.2022 16:30.02.845] [LOG]   Launching application.
[8846:0106/163005.246382:ERROR:viz_main_impl.cc(161)] Exiting GPU process due to errors during initialization
[8886:0106/163005.631441:ERROR:sandbox_linux.cc(376)] InitializeSandbox() called with multiple threads in process gpu-process.
[06.01.2022 16:30.12.077] [LOG]   Create new calendarfetcher for url: http://www.calendarlabs.com/ical-calendar/ics/76/US_Holidays.ics - Interval: 300000
[06.01.2022 16:30.12.157] [LOG]   Create new newsfetcher for url: https://rss.nytimes.com/services/xml/rss/nyt/HomePage.xml - Interval: 300000
[06.01.2022 16:30.12.258] [INFO]  Checking git for module: default
[06.01.2022 16:30.13.590] [INFO]  Calendar-Fetcher: Broadcasting 10 events.
[06.01.2022 16:30.13.638] [INFO]  Newsfeed-Fetcher: Broadcasting 64 items.

sdetweil

@richard238 ok!.. run this to get rid of the sandbox problem

bash -c  "$(curl -sL https://raw.githubusercontent.com/sdetweil/MagicMirror_scripts/master/fixsandbox)"

then

cd ~/MagicMirror/modules
# save the new default modules folder
mv default default.new
cd ..
# copy all the modules from old install (incl default) preserve ownership and dates, need sudo to copy git info 
sudo cp -r -p ~/MagicMirror.save/modules/* modules
cd modules
# remove the copied default modules
rm -rf default
# restore the saved default
mv default.new default

copy your full function config.js to MagicMirror/config
and try it out

cd ~/MagicMirror
npm start

Richard238

@sdetweil

pi@magicmirror:~ $ cd ~/MagicMirror/modules
pi@magicmirror:~/MagicMirror/modules $ mv default default.new
pi@magicmirror:~/MagicMirror/modules $ sudo cp -r -p ~/MagicMirror.save/modules/* modules
cp: target 'modules' is not a directory

Tried it without the space…

pi@magicmirror:~/MagicMirror/modules $ sudo cp -r -p ~/MagicMirror.save/modules/*modules
cp: missing destination file operand after '/home/pi/MagicMirror.save/modules/*modules'
Try 'cp --help' for more information.
pi@magicmirror:~/MagicMirror/modules $

Richard238

@richard238

I have to leave shortly Sam.

Thank you for all your help with this today, I’ll try again tomorrow.

Richard.

sdetweil

@richard238 ok

you forgot the cd …

cd ..
# copy all the modules from old install (incl default) preserve ownership and dates, need sudo to copy git info 
sudo cp -r -p ~/MagicMirror.save/modules/* modules

Richard238

@sdetweil

Trying to rename config.js to sample,

Error when getting information for file “/home/pi/MagicMirror/config/config.js”: No such file or directory
Error renaming file /home/pi/MagicMirror/config/config.js: No such file or directory

Yet I can see it, I can query it for permissions…

Back tomorrow.
Richard.

sdetweil

@richard238 said in v2.18.0 update gave black screen, then nothing.:

Error when getting information for file “/home/pi/MagicMirror/config/config.js”

you need to copy from save

cd ~/MagicMirror.save/config
cp -p config.js ~/Magicmirror/config

Richard238

@sdetweil

Good morning Sam.

Tried that late yesterday, and yes, it works.
And this morning, I copied

custom.css

from

/home/pi/MagicMirror.save/css

to

/home/pi/MagicMirror/css

This too is working perfectly.

Is there anything else to do, housekeeping maybe, or is that it now?

sdetweil

@richard238 if everything is running ok then I think you are done, and can delete the
MagicMirror.save folder

Richard238

@sdetweil

Ok, I’ll do that then.

Do we know what the cause of all this was, was it something to do with a mismatch in versions of node and npm?

sdetweil

@richard238 no idea what caused it.

there clearly was an error somewhere in the upgrade process, maybe reported and missed, or unreported.

but can u send me the MagicMirror.save/installers/upgrade.log

Richard238

@sdetweil

That’s a huge file, what’s the best way to send it?

sdetweil

@richard238 use zip to make it smaller

do

cd ~
zip logfile.zip ~/MagicMirror.save/installers/upgrade.log
# rename logfile.zip so it can be emailed
mv logfile.zip logfile.txt

then use email to send logfile.txt to me.
same userid at gmail

Richard238

@sdetweil

bash: zip: command not found

Zipped it on Windows, renamed and emailed.

sdetweil

@richard238 thx…

looking back thru the topic, the

Module.createRequire is not a function is because of downlevel node.
the eslint library depends on node 14+ for that to work.
(from npm run config:check)

sdetweil

@richard238 if you haven’t deleted yet, can u try something

because you did

pi@magicmirror:~/MagicMirror $ npm init -y

in the mm folder, instead of the module folder, this overwrote the shipped package.json

so,

do

cd ~/MagicMirror.save
git checkout package.json
rm -rf node_modules
rm package.lock.json
npm install --only=prod

then stop good mm if running and then do , in the MagicMirror.save folder

npm start

Richard238

@sdetweil

That’s given a very basic, but working MM

pi@magicmirror:~ $ cd ~/MagicMirror.save
pi@magicmirror:~/MagicMirror.save $ git checkout package.json
pi@magicmirror:~/MagicMirror.save $ rm -rf node_modules
pi@magicmirror:~/MagicMirror.save $ rm package.lock.json
rm: cannot remove 'package.lock.json': No such file or directory
pi@magicmirror:~/MagicMirror.save $ npm install --only=prod

> magicmirror@2.18.0 install
> echo "Installing vendor files ...
> " && cd vendor && npm install --loglevel=error

Installing vendor files ...


up to date, audited 10 packages in 4s

found 0 vulnerabilities

> magicmirror@2.18.0 postinstall
> npm run install-fonts && echo "MagicMirror installation finished successfully! 
> "


> magicmirror@2.18.0 install-fonts
> echo "Installing fonts ...
> " && cd fonts && npm install --loglevel=error

Installing fonts ...


up to date, audited 2 packages in 3s

found 0 vulnerabilities
MagicMirror installation finished successfully! 


> magicmirror@2.18.0 prepare
> [ -f node_modules/.bin/husky ] && husky install || echo no husky installed.

no husky installed.

added 266 packages, and audited 267 packages in 2m

19 packages are looking for funding
  run `npm fund` for details

found 0 vulnerabilities
pi@magicmirror:~/MagicMirror.save $ npm start

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

[07.01.2022 14:15.55.560] [LOG]   Starting MagicMirror: v2.18.0
[07.01.2022 14:15.55.585] [LOG]   Loading config ...
[07.01.2022 14:15.55.607] [LOG]   Loading module helpers ...
[07.01.2022 14:15.55.617] [LOG]   No helper found for module: alert.
[07.01.2022 14:15.55.675] [LOG]   Initializing new module helper ...
[07.01.2022 14:15.55.679] [LOG]   Module helper loaded: updatenotification
[07.01.2022 14:15.55.683] [LOG]   No helper found for module: clock.
[07.01.2022 14:15.56.139] [LOG]   Initializing new module helper ...
[07.01.2022 14:15.56.141] [LOG]   Module helper loaded: calendar
[07.01.2022 14:15.56.146] [LOG]   No helper found for module: compliments.
[07.01.2022 14:15.56.159] [LOG]   Initializing new module helper ...
[07.01.2022 14:15.56.161] [LOG]   Module helper loaded: currentweather
[07.01.2022 14:15.56.168] [LOG]   Initializing new module helper ...
[07.01.2022 14:15.56.170] [LOG]   Module helper loaded: weatherforecast
[07.01.2022 14:15.56.248] [LOG]   Initializing new module helper ...
[07.01.2022 14:15.56.250] [LOG]   Module helper loaded: newsfeed
[07.01.2022 14:15.56.253] [LOG]   All module helpers loaded.
[07.01.2022 14:15.56.571] [LOG]   Starting server on port 8080 ... 
[07.01.2022 14:15.56.602] [LOG]   Server started ...
[07.01.2022 14:15.56.604] [LOG]   Connecting socket for: updatenotification
[07.01.2022 14:15.56.606] [LOG]   Starting module helper: updatenotification
[07.01.2022 14:15.56.607] [LOG]   Connecting socket for: calendar
[07.01.2022 14:15.56.609] [LOG]   Starting node helper for: calendar
[07.01.2022 14:15.56.610] [LOG]   Connecting socket for: currentweather
[07.01.2022 14:15.56.611] [WARN]  The module 'currentweather' is deprecated in favor of the 'weather'-module, please refer to the documentation for a migration path
[07.01.2022 14:15.56.614] [LOG]   Connecting socket for: weatherforecast
[07.01.2022 14:15.56.616] [WARN]  The module 'weatherforecast' is deprecated in favor of the 'weather'-module, please refer to the documentation for a migration path
[07.01.2022 14:15.56.617] [LOG]   Connecting socket for: newsfeed
[07.01.2022 14:15.56.620] [LOG]   Starting node helper for: newsfeed
[07.01.2022 14:15.56.622] [LOG]   Sockets connected & modules started ...
[07.01.2022 14:15.57.465] [LOG]   Launching application.
[12477:0107/141600.023451:ERROR:viz_main_impl.cc(161)] Exiting GPU process due to errors during initialization
[12538:0107/141600.426774:ERROR:sandbox_linux.cc(376)] InitializeSandbox() called with multiple threads in process gpu-process.
[07.01.2022 14:16.03.157] [LOG]   Create new calendarfetcher for url: http://www.calendarlabs.com/templates/ical/US-Holidays.ics - Interval: 300000
[07.01.2022 14:16.03.201] [LOG]   Create new newsfetcher for url: http://www.nytimes.com/services/xml/rss/nyt/HomePage.xml - Interval: 300000
[07.01.2022 14:16.03.219] [INFO]  Checking git for module: default
[07.01.2022 14:16.04.177] [INFO]  Calendar-Fetcher: Broadcasting 0 events.
[07.01.2022 14:16.04.552] [INFO]  Newsfeed-Fetcher: Broadcasting 57 items.

sdetweil

@richard238 we may have copied back the config.js.sample before we gave up