Read the statement by Michael Teeuw here.
Fresh install but pm2 error
-
@Hubschra01 good, thank you
last time you said
But on the Mirror there is only the Desktop from Buster shown, not the Mirror Screen
did the mirror app display correctly on the display this time? looks like it should have
-
Yes it did.
I Start the Mirror again withpm2 restart MagicMirror
and it works.
Next step i flush the pm2 log and restart pm2 again.
All works fine no errors.But if i reboot the pi the error appear again in the pm2 log…
-
-
@sdetweil
OK i did it. what else?
if i reboot pm2 log show this.pi@raspberrypi:~ $ 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 | 2020-01-20T15:12:28: PM2 log: PM2 version : 4.2.1 PM2 | 2020-01-20T15:12:28: PM2 log: Node.js version : 10.18.1 PM2 | 2020-01-20T15:12:28: PM2 log: Current arch : arm PM2 | 2020-01-20T15:12:28: PM2 log: PM2 home : /home/pi/.pm2 PM2 | 2020-01-20T15:12:28: PM2 log: PM2 PID file : /home/pi/.pm2/pm2.pid PM2 | 2020-01-20T15:12:28: PM2 log: RPC socket file : /home/pi/.pm2/rpc.sock PM2 | 2020-01-20T15:12:28: PM2 log: BUS socket file : /home/pi/.pm2/pub.sock PM2 | 2020-01-20T15:12:28: PM2 log: Application log path : /home/pi/.pm2/logs PM2 | 2020-01-20T15:12:28: PM2 log: Worker Interval : 30000 PM2 | 2020-01-20T15:12:28: PM2 log: Process dump file : /home/pi/.pm2/dump.pm2 PM2 | 2020-01-20T15:12:28: PM2 log: Concurrent actions : 2 PM2 | 2020-01-20T15:12:28: PM2 log: SIGTERM timeout : 1600 PM2 | 2020-01-20T15:12:28: PM2 log: =============================================================================== PM2 | 2020-01-20T15:12:28: PM2 log: App [MagicMirror:0] starting in -fork mode- PM2 | 2020-01-20T15:12:28: PM2 log: App [MagicMirror:0] online /home/pi/.pm2/logs/MagicMirror-error.log last 15 lines: 0|MagicMir | npm ERR! code ELIFECYCLE 0|MagicMir | npm ERR! errno 1 0|MagicMir | npm ERR! magicmirror@2.10.1 start: `./run-start.sh` 0|MagicMir | npm ERR! Exit status 1 0|MagicMir | npm ERR! 0|MagicMir | npm ERR! Failed at the magicmirror@2.10.1 start script. 0|MagicMir | npm ERR! This is probably not a problem with npm. There is likely additional logging output above. 0|MagicMir | 0|MagicMir | npm ERR! A complete log of this run can be found in: 0|MagicMir | npm ERR! /home/pi/.npm/_logs/2020-01-20T14_12_10_107Z-debug.log /home/pi/.pm2/logs/MagicMirror-out.log last 15 lines: 0|MagicMir | [15:12:38.792] [LOG] Initializing new module helper ... 0|MagicMir | [15:12:38.793] [LOG] Module helper loaded: newsfeed 0|MagicMir | [15:12:38.794] [LOG] All module helpers loaded. 0|MagicMir | [15:12:38.795] [LOG] Starting server on port 8080 ... 0|MagicMir | [15:12:38.819] [LOG] Server started ... 0|MagicMir | [15:12:38.820] [LOG] Connecting socket for: updatenotification 0|MagicMir | [15:12:38.822] [LOG] Connecting socket for: calendar 0|MagicMir | [15:12:38.823] [LOG] Starting node helper for: calendar 0|MagicMir | [15:12:38.825] [LOG] Connecting socket for: newsfeed 0|MagicMir | [15:12:38.826] [LOG] Starting module: newsfeed 0|MagicMir | [15:12:38.827] [LOG] Sockets connected & modules started ... 0|MagicMir | [15:12:39.460] [LOG] Launching application. 0|MagicMir | [15:12:43.347] [LOG] Create new calendar fetcher for url: https:
-
@Hubschra01 said in Fresh install but pm2 error:
/home/pi/.npm/_logs/2020-01-20T14_12_10_107Z-debug.log
weird…
can u show that log
/home/pi/.npm/_logs/2020-01-20T14_12_10_107Z-debug.log -
@sdetweil
sure here it is:0 info it worked if it ends with ok 1 verbose cli [ '/usr/bin/node', '/usr/bin/npm', 'start' ] 2 info using npm@6.13.4 3 info using node@v10.18.1 4 verbose run-script [ 'prestart', 'start', 'poststart' ] 5 info lifecycle magicmirror@2.10.1~prestart: magicmirror@2.10.1 6 info lifecycle magicmirror@2.10.1~start: magicmirror@2.10.1 7 verbose lifecycle magicmirror@2.10.1~start: unsafe-perm in lifecycle true 8 verbose lifecycle magicmirror@2.10.1~start: PATH: /usr/lib/node_modules/npm/n$ 9 verbose lifecycle magicmirror@2.10.1~start: CWD: /home/pi/MagicMirror 10 silly lifecycle magicmirror@2.10.1~start: Args: [ '-c', './run-start.sh' ] 11 silly lifecycle magicmirror@2.10.1~start: Returned: code: 1 signal: null 12 info lifecycle magicmirror@2.10.1~start: Failed to exec start script 13 verbose stack Error: magicmirror@2.10.1 start: `./run-start.sh` 13 verbose stack Exit status 1 13 verbose stack at EventEmitter.<anonymous> (/usr/lib/node_modules/npm/nod$ 13 verbose stack at EventEmitter.emit (events.js:198:13) 13 verbose stack at ChildProcess.<anonymous> (/usr/lib/node_modules/npm/nod$ 13 verbose stack at ChildProcess.emit (events.js:198:13) 13 verbose stack at maybeClose (internal/child_process.js:982:16) 13 verbose stack at Process.ChildProcess._handle.onexit (internal/child_pro$ 14 verbose pkgid magicmirror@2.10.1 15 verbose cwd /home/pi/MagicMirror 16 verbose Linux 4.19.75-v7+ 17 verbose argv "/usr/bin/node" "/usr/bin/npm" "start" 18 verbose node v10.18.1 19 verbose npm v6.13.4 20 error code ELIFECYCLE 21 error errno 1 22 error magicmirror@2.10.1 start: `./run-start.sh` 22 error Exit status 1 23 error Failed at the magicmirror@2.10.1 start script. 23 error This is probably not a problem with npm. There is likely additional lo$ 24 verbose exit [ 1, true ]
-
@Hubschra01 can u show output of
ls ~/MagicMirror/run-start.sh -laF
mine looks like
-rwxrwxr-x 1 sam sam 2399 Jan 16 09:55 /home/sam/MagicMirror/run-start.sh*
-
-rwxr-xr-x 1 pi pi 1989 Jan 16 20:05 /home/pi/MagicMirror/run-start.sh*
-
@Hubschra01 weird…
can u change line 1 of run-start.sh to
#!/bin/bash -x
do pm2 flush
and then rebootthen show the pm2 logs --lines=100
this has got to be a permissions error
-
@sdetweil
here it is…PM2 | 2020-01-20T16:05:29: PM2 log: App [MagicMirror:0] exited with code [2] via signal [SIGINT] PM2 | 2020-01-20T16:05:29: PM2 log: App [MagicMirror:0] starting in -fork mode- PM2 | 2020-01-20T16:05:29: PM2 log: App [MagicMirror:0] online PM2 | 2020-01-20T16:05:31: PM2 log: Stopping app:MagicMirror id:0 PM2 | 2020-01-20T16:05:31: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:31: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:32: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:33: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:33: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:33: PM2 log: pid=1305 msg=failed to kill - retryin g in 100ms PM2 | 2020-01-20T16:05:33: PM2 log: Process with pid 1305 still alive aft er 1600ms, sending it SIGKILL now... PM2 | 2020-01-20T16:05:33: PM2 log: App [MagicMirror:0] exited with code [0] via signal [SIGKILL] PM2 | 2020-01-20T16:05:33: PM2 log: pid=1305 msg=process killed PM2 | 2020-01-20T16:05:33: PM2 log: PM2 successfully stopped PM2 | 2020-01-20T16:05:48: PM2 log: ===================================== ========================================== PM2 | 2020-01-20T16:05:48: PM2 log: --- New PM2 Daemon started ---------- ------------------------------------------ PM2 | 2020-01-20T16:05:48: PM2 log: Time : Mon Jan 20 202 0 16:05:48 GMT+0100 (GMT+01:00) PM2 | 2020-01-20T16:05:48: PM2 log: PM2 version : 4.2.1 PM2 | 2020-01-20T16:05:48: PM2 log: Node.js version : 10.18.1 PM2 | 2020-01-20T16:05:48: PM2 log: Current arch : arm PM2 | 2020-01-20T16:05:48: PM2 log: PM2 home : /home/pi/.pm2 PM2 | 2020-01-20T16:05:48: PM2 log: PM2 PID file : /home/pi/.pm2/ pm2.pid PM2 | 2020-01-20T16:05:48: PM2 log: RPC socket file : /home/pi/.pm2/ rpc.sock PM2 | 2020-01-20T16:05:48: PM2 log: BUS socket file : /home/pi/.pm2/ pub.sock PM2 | 2020-01-20T16:05:48: PM2 log: Application log path : /home/pi/.pm2/ logs PM2 | 2020-01-20T16:05:48: PM2 log: Worker Interval : 30000 PM2 | 2020-01-20T16:05:48: PM2 log: Process dump file : /home/pi/.pm2/ dump.pm2 PM2 | 2020-01-20T16:05:48: PM2 log: Concurrent actions : 2 PM2 | 2020-01-20T16:05:48: PM2 log: SIGTERM timeout : 1600 PM2 | 2020-01-20T16:05:48: PM2 log: ===================================== ========================================== PM2 | 2020-01-20T16:05:48: PM2 log: App [MagicMirror:0] starting in -fork mode- PM2 | 2020-01-20T16:05:49: PM2 log: App [MagicMirror:0] online /home/pi/.pm2/logs/MagicMirror-error.log last 100 lines: 0|MagicMir | ./run-start.sh: Zeile 68: Syntaxfehler beim unerwarteten Wort `fi' 0|MagicMir | ./run-start.sh: Zeile 68: `fi' 0|MagicMir | npm ERR! code ELIFECYCLE 0|MagicMir | npm ERR! errno 2 0|MagicMir | npm ERR! magicmirror@2.10.1 start: `./run-start.sh` 0|MagicMir | npm ERR! Exit status 2 0|MagicMir | npm ERR! 0|MagicMir | npm ERR! Failed at the magicmirror@2.10.1 start script. 0|MagicMir | npm ERR! This is probably not a problem with npm. There is likely a dditional logging output above. 0|MagicMir | 0|MagicMir | npm ERR! A complete log of this run can be found in: 0|MagicMir | npm ERR! /home/pi/.npm/_logs/2020-01-20T15_05_29_835Z-debug.log 0|MagicMir | + ./untrack-css.sh 0|MagicMir | + '[' -z :0 ']' 0|MagicMir | ++ uname -m 0|MagicMir | + arch=armv7l 0|MagicMir | + false=false 0|MagicMir | ++ grep -v '^\s//' config/config.js 0|MagicMir | ++ grep -i serveronly: 0|MagicMir | ++ tr -d ',"'\''' 0|MagicMir | ++ awk '{print tolower($2)}' 0|MagicMir | + serveronly= 0|MagicMir | + serveronly=false 0|MagicMir | ++ pgrep Xorg 0|MagicMir | + xorg= 0|MagicMir | ++ uname 0|MagicMir | + mac=Linux 0|MagicMir | + '[' false. '!=' false. -o armv7l == armv6l ']' 0|MagicMir | + '[' . == . -a Linux '!=' Darwin ']' 0|MagicMir | + '[' false. == true. -o . == . ']' 0|MagicMir | + node serveronly 0|MagicMir | + ./untrack-css.sh 0|MagicMir | + '[' -z :0 ']' 0|MagicMir | ++ uname -m 0|MagicMir | + arch=armv7l 0|MagicMir | + false=false 0|MagicMir | ++ grep -i serveronly: 0|MagicMir | ++ tr -d ',"'\''' 0|MagicMir | ++ awk '{print tolower($2)}' 0|MagicMir | ++ grep -v '^\s//' config/config.js 0|MagicMir | + serveronly= 0|MagicMir | + serveronly=false 0|MagicMir | ++ pgrep Xorg 0|MagicMir | + xorg=437 0|MagicMir | ++ uname 0|MagicMir | + mac=Linux 0|MagicMir | + '[' false. '!=' false. -o armv7l == armv6l ']' 0|MagicMir | + '[' 437. == . -a Linux '!=' Darwin ']' 0|MagicMir | + electron js/electron.js /home/pi/.pm2/logs/MagicMirror-out.log last 100 lines: 0|MagicMir | 0|MagicMir | > magicmirror@2.10.1 start /home/pi/MagicMirror 0|MagicMir | > ./run-start.sh 0|MagicMir | 0|MagicMir | [16:05:33.029] [LOG] Starting MagicMirror: v2.10.1 0|MagicMir | [16:05:33.045] [LOG] Loading config ... 0|MagicMir | [16:05:33.054] [LOG] Loading module helpers ... 0|MagicMir | [16:05:33.057] [LOG] No helper found for module: alert. 0|MagicMir | [16:05:33.129] [LOG] Initializing new module helper ... 0|MagicMir | [16:05:33.131] [LOG] Module helper loaded: updatenotification 0|MagicMir | [16:05:33.132] [LOG] No helper found for module: clock. 0|MagicMir | 0|MagicMir | > magicmirror@2.10.1 start /home/pi/MagicMirror 0|MagicMir | > ./run-start.sh 0|MagicMir | 0|MagicMir | [16:05:56.837] [LOG] Starting MagicMirror: v2.10.1 0|MagicMir | [16:05:56.853] [LOG] Loading config ... 0|MagicMir | [16:05:56.872] [LOG] Loading module helpers ... 0|MagicMir | [16:05:56.875] [LOG] No helper found for module: alert. 0|MagicMir | [16:05:57.006] [LOG] Initializing new module helper ... 0|MagicMir | [16:05:57.012] [LOG] Module helper loaded: updatenotification 0|MagicMir | [16:05:57.014] [LOG] No helper found for module: clock. 0|MagicMir | [16:05:58.224] [LOG] Initializing new module helper ... 0|MagicMir | [16:05:58.225] [LOG] Module helper loaded: calendar 0|MagicMir | [16:05:58.226] [LOG] No helper found for module: currentweather. 0|MagicMir | [16:05:58.227] [LOG] No helper found for module: weatherforecast . 0|MagicMir | [16:05:58.315] [LOG] Initializing new module helper ... 0|MagicMir | [16:05:58.316] [LOG] Module helper loaded: newsfeed 0|MagicMir | [16:05:58.316] [LOG] All module helpers loaded. 0|MagicMir | [16:05:58.318] [LOG] Starting server on port 8080 ... 0|MagicMir | [16:05:58.341] [LOG] Server started ... 0|MagicMir | [16:05:58.343] [LOG] Connecting socket for: updatenotification 0|MagicMir | [16:05:58.345] [LOG] Connecting socket for: calendar 0|MagicMir | [16:05:58.346] [LOG] Starting node helper for: calendar 0|MagicMir | [16:05:58.347] [LOG] Connecting socket for: newsfeed 0|MagicMir | [16:05:58.349] [LOG] Starting module: newsfeed 0|MagicMir | [16:05:58.349] [LOG] Sockets connected & modules started ... 0|MagicMir | [16:05:59.000] [LOG] Launching application. 0|MagicMir | [16:06:02.809] [LOG] Create new calendar fetcher for url: https: