SOLVED Several duplicate and recurring log messages in event log

[esawtooth]

I am getting several recurrent messages in the event log every couple of minutes with the following text:

"Cloudron started with version 6.0.1"
{
  "version": "6.0.1"
}

Which process could be raising these events so frequently and how can I debug the issue? Any pointers on this would be great. I am concerned that some service might be trying to start over and over again.

[girish]

@esawtooth Your suspicion is correct. I think that the box service is restarting over and over. Can you check the logs ? /home/yellowtent/platformdata/logs/box.log . You will see a big banner with the version number whenever the box code restarts.

[esawtooth]

@girish said in Several duplicate and recurring log messages in event log:

/home/yellowtent/platformdata/logs/box.log

I am seeing the following log messages repeat in that file:

2021-01-08T18:02:04.016Z box:server ==========================================
2021-01-08T18:02:04.016Z box:server            Cloudron 6.0.1
2021-01-08T18:02:04.020Z box:server ==========================================
2021-01-08T18:02:04.062Z box:settings initCache: pre-load settings
2021-01-08T18:02:04.076Z box:tasks stopTask: stopping all tasks
2021-01-08T18:02:04.077Z box:shell stopTask spawn: /usr/bin/sudo -S /home/yellowtent/box/src/scripts/stoptask.sh all
2021-01-08T18:02:04.130Z box:shell removeCollectdProfile spawn: /usr/bin/sudo -S /home/yellowtent/box/src/scripts/configurecollectd.sh remove cloudron-backup
2021-01-08T18:02:04.140Z box:shell removeCollectdProfile (stdout): Restarting collectd

2021-01-08T18:02:04.187Z box:shell removeCollectdProfile (stdout): Removing collectd stats of cloudron-backup

2021-01-08T18:02:04.190Z box:reverseproxy writeDashboardConfig: writing admin config for <server>
2021-01-08T18:02:04.237Z box:shell reload spawn: /usr/bin/sudo -S /home/yellowtent/box/src/scripts/reloadnginx.sh
2021-01-08T18:02:04.296Z box:platform initializing addon infrastructure
2021-01-08T18:02:04.297Z box:platform platform is uptodate at version 48.18.0
2021-01-08T18:02:04.297Z box:platform onPlatformReady: platform is ready. infra changed: false
2021-01-08T18:02:04.297Z box:apps schedulePendingTasks: scheduling app tasks
2021-01-08T18:02:04.298Z box:cron startJobs: starting cron jobs
2021-01-08T18:02:04.330Z box:cron backupConfigChanged: schedule 00 00 3 * * * (Asia/Kolkata)
2021-01-08T18:02:04.337Z box:cron autoupdatePatternChanged: pattern - 00 00 23 * * * (Asia/Kolkata)
2021-01-08T18:02:04.345Z box:cron Dynamic DNS setting changed to false
2021-01-08T18:02:04.354Z box:notifications alert: id=backupConfig title=Backup configuration is unsafe
2021-01-08T18:02:04.618Z box:dockerproxy startDockerProxy: started proxy on port 3003
Cloudron is up and running. Logs are at /home/yellowtent/platformdata/logs/box.log
2021-01-08T18:02:33.337Z box:apphealthmonitor app health: 22 alive / 10 dead.
2021-01-08T18:02:33.339Z box:apphealthmonitor app health: 22 alive / 10 dead.
2021-01-08T18:02:34.219Z box:apphealthmonitor app health: 22 alive / 10 dead.
2021-01-08T18:02:34.840Z box:reverseproxy writeDefaultConfig: writing configs for endpoint "ip"
2021-01-08T18:02:34.845Z box:shell reload spawn: /usr/bin/sudo -S /home/yellowtent/box/src/scripts/reloadnginx.sh
2021-01-08T18:03:00.014Z box:scheduler sync: adding jobs of 05fed728-cb8b-484d-8a12-a5c106b517cb (rssreader.<server>.in)
2021-01-08T18:04:00.019Z box:scheduler sync: adding jobs of 05fed728-cb8b-484d-8a12-a5c106b517cb (rssreader.<server>.in)
ERROR TypeError: Cannot read property 'id' of undefined
    at /home/yellowtent/box/src/scheduler.js:82:96
    at /home/yellowtent/box/src/docker.js:375:63
    at /home/yellowtent/box/node_modules/dockerode/lib/docker.js:73:23
    at /home/yellowtent/box/node_modules/docker-modem/lib/modem.js:265:7
    at getCause (/home/yellowtent/box/node_modules/docker-modem/lib/modem.js:287:7)
    at Modem.buildPayload (/home/yellowtent/box/node_modules/docker-modem/lib/modem.js:256:5)
    at IncomingMessage.<anonymous> (/home/yellowtent/box/node_modules/docker-modem/lib/modem.js:232:14)
    at IncomingMessage.emit (events.js:203:15)
    at endReadableNT (_stream_readable.js:1145:12)
    at process._tickCallback (internal/process/next_tick.js:63:19) [ /home/yellowtent/box/box.js:61:17 ]
2021-01-08T18:04:03.893Z box:server ==========================================
2021-01-08T18:04:03.894Z box:server            Cloudron 6.0.1
2021-01-08T18:04:03.898Z box:server ==========================================

[esawtooth]

I think this has started happening after I rebooted my cloudron after there were some ubuntu security updates installed. rssreader.<server> refers to the FreshRSS app, if that's of relevance. It is in stopped state on the dashboard.

[girish]

@esawtooth Ah thanks, https://git.cloudron.io/cloudron/box/-/commit/f2fba1886061a70bd49bd2874733814d6d925a2a is the fix.

Just change /home/yellowtent/box/src/scheduler.js line 82 from

                debug(`createJobs: ${taskName} (${app.fqdn}) will run in container ${container.id}`);

to

                debug(`createJobs: ${taskName} (${app.fqdn}) will run in container ${containerName}`);

It's just replacing container.id with containerName. Then systemctl restart box.

[esawtooth]

@girish That fixed it. Thanks!