2021-12-06T17:30:26+0100 <info> gateway.backup.js:46 (Gateway.backup) Gateway backup: Encrypting backup
2021-12-06T17:30:26+0100 <info> gateway.backup.js:54 (Gateway.backup) Gateway backup: Uploading backup
2021-12-06T17:30:26+0100 <info> gateway.backup.js:59 (Gateway.backup) Gladys backup uploaded with success to Gladys Gateway. gladys-db-backup-2021-12-6-17-30-26.db
2021-12-06T17:31:10+0100 <info> gateway.restoreBackupEvent.js:15 (Gateway.restoreBackupEvent) Receiving restore backup event. File url = https://fra1.digitaloceanspaces.com/gladys-gateway-backup/6d50a389-3a95-482c-a7f2-f1aca39338c1.enc
2021-12-06T17:33:12+0100 <info> gateway.downloadBackup.js:45 (Gateway.downloadBackup) Gladys backup downloaded with success.
2021-12-06T17:33:12+0100 <info> gateway.restoreBackup.js:15 (Gateway.restoreBackup) Restoring back up /var/lib/gladysassistant/backups/restore/6d50a389-3a95-482c-a7f2-f1aca39338c1.db
2021-12-06T17:33:12+0100 <info> gateway.restoreBackup.js:21 (Gateway.restoreBackup) Testing if backup is a valid Gladys SQLite database.
2021-12-06T17:33:12+0100 <info> gateway.restoreBackup.js:33 (Gateway.restoreBackup) Backup seems to be a valid file. Restoring.
2021-12-06T17:33:24+0100 <error> index.js:15 (process.<anonymous>) unhandledRejection catched: Promise {
<rejected> Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async Function.findOne (/src/server/node_modules/sequelize/lib/model.js:1917:12)
at async DeviceManager.get (/src/server/lib/device/device.get.js:83:21)
at async BluetoothManager.scanPresence (/src/server/services/bluetooth/lib/commands/bluetooth.scanPresence.js:10:19)
}
2021-12-06T17:33:24+0100 <error> index.js:16 (process.<anonymous>) Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async Function.findOne (/src/server/node_modules/sequelize/lib/model.js:1917:12)
at async DeviceManager.get (/src/server/lib/device/device.get.js:83:21)
at async BluetoothManager.scanPresence (/src/server/services/bluetooth/lib/commands/bluetooth.scanPresence.js:10:19)
2021-12-06T17:34:24+0100 <error> index.js:15 (process.<anonymous>) unhandledRejection catched: Promise {
<rejected> Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async Function.findOne (/src/server/node_modules/sequelize/lib/model.js:1917:12)
at async DeviceManager.get (/src/server/lib/device/device.get.js:83:21)
at async BluetoothManager.scanPresence (/src/server/services/bluetooth/lib/commands/bluetooth.scanPresence.js:10:19)
}
2021-12-06T17:34:24+0100 <error> index.js:16 (process.<anonymous>) Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async Function.findOne (/src/server/node_modules/sequelize/lib/model.js:1917:12)
at async DeviceManager.get (/src/server/lib/device/device.get.js:83:21)
at async BluetoothManager.scanPresence (/src/server/services/bluetooth/lib/commands/bluetooth.scanPresence.js:10:19)
2021-12-06T17:35:24+0100 <error> index.js:15 (process.<anonymous>) unhandledRejection catched: Promise {
<rejected> Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async Function.findOne (/src/server/node_modules/sequelize/lib/model.js:1917:12)
at async DeviceManager.get (/src/server/lib/device/device.get.js:83:21)
at async BluetoothManager.scanPresence (/src/server/services/bluetooth/lib/commands/bluetooth.scanPresence.js:10:19)
}
2021-12-06T17:35:24+0100 <error> index.js:16 (process.<anonymous>) Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async Function.findOne (/src/server/node_modules/sequelize/lib/model.js:1917:12)
at async DeviceManager.get (/src/server/lib/device/device.get.js:83:21)
at async BluetoothManager.scanPresence (/src/server/services/bluetooth/lib/commands/bluetooth.scanPresence.js:10:19)
2021-12-06T17:35:25+0100 <error> index.js:52 (Timeout.syncAllUsers [as _onTimeout]) Error: ConnectionManager.getConnection was called after the connection manager was closed!
at ConnectionManager.getConnection (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:113:13)
at /src/server/node_modules/sequelize/lib/sequelize.js:613:111
at /src/server/node_modules/retry-as-promised/index.js:70:21
at new Promise (<anonymous>)
at retryAsPromised (/src/server/node_modules/retry-as-promised/index.js:60:10)
at Sequelize.query (/src/server/node_modules/sequelize/lib/sequelize.js:606:12)
at SQLiteQueryInterface.select (/src/server/node_modules/sequelize/lib/dialects/abstract/query-interface.js:952:33)
at Function.findAll (/src/server/node_modules/sequelize/lib/model.js:1753:47)
at async User.get (/src/server/lib/user/user.get.js:59:17)
at async Timeout.syncAllUsers [as _onTimeout] (/src/server/services/caldav/index.js:37:21)
2021-12-06T17:35:36+0100 <info> gateway.restoreBackup.js:39 (Gateway.restoreBackup) Backup restored. Need reboot now.
2021-12-06T17:35:36+0100 <info> system.shutdown.js:13 (System.shutdown) Database is probably already closed
2021-12-06T17:35:36+0100 <warn> system.shutdown.js:14 (System.shutdown) Error: SQLITE_MISUSE: Database is closed
at /src/server/node_modules/sequelize/lib/dialects/sqlite/connection-manager.js:31:79
at internal/util.js:340:30
at new Promise (<anonymous>)
at internal/util.js:339:12
at /src/server/node_modules/sequelize/lib/dialects/sqlite/connection-manager.js:31:95
at Array.map (<anonymous>)
at ConnectionManager._onProcessExit (/src/server/node_modules/sequelize/lib/dialects/sqlite/connection-manager.js:31:10)
at ConnectionManager.close (/src/server/node_modules/sequelize/lib/dialects/abstract/connection-manager.js:116:23)
at Sequelize.close (/src/server/node_modules/sequelize/lib/sequelize.js:1190:35)
at System.shutdown (/src/server/lib/system/system.shutdown.js:11:26)
at Gateway.restoreBackupEvent (/src/server/lib/gateway/gateway.restoreBackupEvent.js:18:23)
at async EventEmitter.<anonymous> (/src/server/utils/functionsWrapper.js:13:7) {
errno: 21,
code: 'SQLITE_MISUSE'
}
> gladys-server@ start:prod /src/server
> cross-env NODE_ENV=production node index.js
2021-12-06T17:36:04+0100 <info> job.purge.js:17 (Job.purge) Deleting all background jobs created before = Mon Nov 29 2021 17:36:04 GMT+0100 (Central European Standard Time)
Initialising OpenZWave 1.6.0 binary addon for Node.JS.
OpenZWave Security API is ENABLED
ZWave device db : /usr/local/etc/openzwave
User settings path : /src/server/services/zwave/node_modules/openzwave-shared/build/Release/../../
Option Overrides : --Logging false --ConsoleOutput false --SaveConfiguration true
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service example was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service philips-hue was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service rtsp-camera was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service zwave was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service tasmota was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service ewelink was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service tp-link was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> service.startAll.js:30 () Service zigbee2mqtt was manually stopped, so it is ignored at startup
2021-12-06T17:36:10+0100 <info> index.js:19 (Object.start) Starting Telegram service
2021-12-06T17:36:10+0100 <info> service.start.js:40 (Service.start) Service telegram is not configured, so it was not started.
2021-12-06T17:36:10+0100 <info> index.js:64 (Object.start) Starting CalDAV service
2021-12-06T17:36:10+0100 <info> index.js:20 (Object.start) Starting Open Weather service
2021-12-06T17:36:10+0100 <info> index.js:16 (Object.start) Starting MQTT service
2021-12-06T17:36:11+0100 <warn> service.start.js:44 (Service.start) Unable to start service mqtt Error: (HTTP code 301) unexpected -
at /src/server/node_modules/docker-modem/lib/modem.js:301:17
at getCause (/src/server/node_modules/docker-modem/lib/modem.js:331:7)
at Modem.buildPayload (/src/server/node_modules/docker-modem/lib/modem.js:300:5)
at IncomingMessage.<anonymous> (/src/server/node_modules/docker-modem/lib/modem.js:275:14)
at IncomingMessage.emit (events.js:412:35)
at endReadableNT (internal/streams/readable.js:1334:12)
at processTicksAndRejections (internal/process/task_queues.js:82:21) {
reason: undefined,
statusCode: 301,
json: <Buffer >
}
2021-12-06T17:36:11+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:36:11+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:36:11+0100 <info> index.js:14 (Object.start) starting GoogleActions service
2021-12-06T17:36:11+0100 <info> index.js:15 (Object.start) Starting Bluetooth service
2021-12-06T17:36:12+0100 <info> bluetooth.initPresenceScanner.js:18 (BluetoothManager.initPresenceScanner) Bluetooth configuration: starting presence scanner
2021-12-06T17:36:12+0100 <info> bluetooth.initPresenceScanner.js:13 (BluetoothManager.initPresenceScanner) Bluetooth configuration: stopping presence scanner
2021-12-06T17:36:12+0100 <info> bluetooth.initPresenceScanner.js:18 (BluetoothManager.initPresenceScanner) Bluetooth configuration: starting presence scanner
2021-12-06T17:36:12+0100 <info> index.js:14 (Object.start) Starting Xiaomi service
2021-12-06T17:36:12+0100 <info> index.js:13 (Object.start) Starting usb service
2021-12-06T17:36:12+0100 <info> scene.dailyUpdate.js:58 () Sunrise today is at 8:13 today, in your timezone = Europe/Paris
2021-12-06T17:36:12+0100 <info> scene.dailyUpdate.js:59 () Sunset today is at 16:41 today, in your timezone = Europe/Paris
2021-12-06T17:36:12+0100 <info> scene.dailyUpdate.js:70 () The sun rose this morning. Not scheduling for today.
2021-12-06T17:36:12+0100 <info> scene.dailyUpdate.js:84 () The sun has already set. Not scheduling for today.
2021-12-06T17:36:12+0100 <info> device.calculateAggregate.js:38 (DeviceManager.calculateAggregate) Calculating aggregates device feature state for interval hourly
2021-12-06T17:36:12+0100 <info> index.js:63 (Server.<anonymous>) Server listening on port 80
2021-12-06T17:36:14+0100 <info> index.js:801 (Socket.<anonymous>) Gladys Gateway: connected in websockets
2021-12-06T17:36:14+0100 <info> gateway.checkIfBackupNeeded.js:27 (Gateway.checkIfBackupNeeded) Not backing up instance to Gladys Gateway, last backup is recent.
2021-12-06T17:36:22+0100 <info> device.calculateAggregate.js:105 (ChildProcess.<anonymous>) device.calculateAggregate: Finishing processing for interval hourly
2021-12-06T17:36:22+0100 <info> device.calculateAggregate.js:38 (DeviceManager.calculateAggregate) Calculating aggregates device feature state for interval daily
2021-12-06T17:36:36+0100 <warn> scene.executeActions.js:37 (executeAction) ServiceNotConfiguredError
at MqttHandler.setValue (/src/server/services/mqtt/lib/setValue.js:19:11)
at DeviceManager.setValue (/src/server/lib/device/device.setValue.js:21:24)
at Object.device.set-value (/src/server/lib/scene/scene.actions.js:30:24)
at executeAction (/src/server/lib/scene/scene.executeActions.js:32:35)
at SceneManager.executeSingleAction (/src/server/lib/scene/scene.executeSingleAction.js:17:11)
at EventEmitter.<anonymous> (/src/server/utils/functionsWrapper.js:13:13)
at EventEmitter.emit (events.js:400:28)
at Event.emit (/src/server/lib/event/index.js:8:16)
at setValueFeature (/src/server/api/controllers/device.controller.js:90:18)
at /src/server/api/middlewares/asyncMiddleware.js:4:19
at Layer.handle [as handle_request] (/src/server/node_modules/express/lib/router/layer.js:95:5)
at next (/src/server/node_modules/express/lib/router/route.js:137:13)
at /src/server/api/middlewares/authMiddleware.js:28:7 {
message: undefined
}
2021-12-06T17:36:40+0100 <warn> scene.executeActions.js:37 (executeAction) ServiceNotConfiguredError
at MqttHandler.setValue (/src/server/services/mqtt/lib/setValue.js:19:11)
at DeviceManager.setValue (/src/server/lib/device/device.setValue.js:21:24)
at Object.device.set-value (/src/server/lib/scene/scene.actions.js:30:24)
at executeAction (/src/server/lib/scene/scene.executeActions.js:32:35)
at SceneManager.executeSingleAction (/src/server/lib/scene/scene.executeSingleAction.js:17:11)
at EventEmitter.<anonymous> (/src/server/utils/functionsWrapper.js:13:13)
at EventEmitter.emit (events.js:400:28)
at Event.emit (/src/server/lib/event/index.js:8:16)
at setValueFeature (/src/server/api/controllers/device.controller.js:90:18)
at /src/server/api/middlewares/asyncMiddleware.js:4:19
at Layer.handle [as handle_request] (/src/server/node_modules/express/lib/router/layer.js:95:5)
at next (/src/server/node_modules/express/lib/router/route.js:137:13)
at /src/server/api/middlewares/authMiddleware.js:28:7 {
message: undefined
}
2021-12-06T17:36:48+0100 <info> device.calculateAggregate.js:105 (ChildProcess.<anonymous>) device.calculateAggregate: Finishing processing for interval daily
2021-12-06T17:36:48+0100 <info> device.calculateAggregate.js:38 (DeviceManager.calculateAggregate) Calculating aggregates device feature state for interval monthly
2021-12-06T17:36:50+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:36:50+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:36:53+0100 <info> device.calculateAggregate.js:105 (ChildProcess.<anonymous>) device.calculateAggregate: Finishing processing for interval monthly
2021-12-06T17:37:33+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:37:33+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:40:55+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:40:55+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:49:04+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:49:04+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:49:13+0100 <info> index.js:16 (Object.start) Starting MQTT service
2021-12-06T17:49:14+0100 <warn> service.start.js:44 (Service.start) Unable to start service mqtt Error: (HTTP code 301) unexpected -
at /src/server/node_modules/docker-modem/lib/modem.js:301:17
at getCause (/src/server/node_modules/docker-modem/lib/modem.js:331:7)
at Modem.buildPayload (/src/server/node_modules/docker-modem/lib/modem.js:300:5)
at IncomingMessage.<anonymous> (/src/server/node_modules/docker-modem/lib/modem.js:275:14)
at IncomingMessage.emit (events.js:412:35)
at endReadableNT (internal/streams/readable.js:1334:12)
at processTicksAndRejections (internal/process/task_queues.js:82:21) {
reason: undefined,
statusCode: 301,
json: <Buffer >
}
2021-12-06T17:49:14+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:49:14+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:49:14+0100 <info> index.js:16 (Object.start) Starting MQTT service
2021-12-06T17:49:14+0100 <warn> service.start.js:44 (Service.start) Unable to start service mqtt Error: (HTTP code 301) unexpected -
at /src/server/node_modules/docker-modem/lib/modem.js:301:17
at getCause (/src/server/node_modules/docker-modem/lib/modem.js:331:7)
at Modem.buildPayload (/src/server/node_modules/docker-modem/lib/modem.js:300:5)
at IncomingMessage.<anonymous> (/src/server/node_modules/docker-modem/lib/modem.js:275:14)
at IncomingMessage.emit (events.js:412:35)
at endReadableNT (internal/streams/readable.js:1334:12)
at processTicksAndRejections (internal/process/task_queues.js:82:21) {
reason: undefined,
statusCode: 301,
json: <Buffer >
}
2021-12-06T17:49:14+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:49:14+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:49:19+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:49:19+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:53:00+0100 <info> index.js:16 (Object.start) Starting MQTT service
2021-12-06T17:53:00+0100 <warn> service.start.js:44 (Service.start) Unable to start service mqtt Error: (HTTP code 301) unexpected -
at /src/server/node_modules/docker-modem/lib/modem.js:301:17
at getCause (/src/server/node_modules/docker-modem/lib/modem.js:331:7)
at Modem.buildPayload (/src/server/node_modules/docker-modem/lib/modem.js:300:5)
at IncomingMessage.<anonymous> (/src/server/node_modules/docker-modem/lib/modem.js:275:14)
at IncomingMessage.emit (events.js:412:35)
at endReadableNT (internal/streams/readable.js:1334:12)
at processTicksAndRejections (internal/process/task_queues.js:82:21) {
reason: undefined,
statusCode: 301,
json: <Buffer >
}
2021-12-06T17:53:00+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:53:00+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:53:01+0100 <info> index.js:16 (Object.start) Starting MQTT service
2021-12-06T17:53:01+0100 <warn> service.start.js:44 (Service.start) Unable to start service mqtt Error: (HTTP code 301) unexpected -
at /src/server/node_modules/docker-modem/lib/modem.js:301:17
at getCause (/src/server/node_modules/docker-modem/lib/modem.js:331:7)
at Modem.buildPayload (/src/server/node_modules/docker-modem/lib/modem.js:300:5)
at IncomingMessage.<anonymous> (/src/server/node_modules/docker-modem/lib/modem.js:275:14)
at IncomingMessage.emit (events.js:412:35)
at endReadableNT (internal/streams/readable.js:1334:12)
at processTicksAndRejections (internal/process/task_queues.js:82:21) {
reason: undefined,
statusCode: 301,
json: <Buffer >
}
2021-12-06T17:53:01+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:53:01+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T17:53:01+0100 <info> index.js:16 (Object.start) Starting MQTT service
2021-12-06T17:53:01+0100 <warn> service.start.js:44 (Service.start) Unable to start service mqtt Error: (HTTP code 301) unexpected -
at /src/server/node_modules/docker-modem/lib/modem.js:301:17
at getCause (/src/server/node_modules/docker-modem/lib/modem.js:331:7)
at Modem.buildPayload (/src/server/node_modules/docker-modem/lib/modem.js:300:5)
at IncomingMessage.<anonymous> (/src/server/node_modules/docker-modem/lib/modem.js:275:14)
at IncomingMessage.emit (events.js:412:35)
at endReadableNT (internal/streams/readable.js:1334:12)
at processTicksAndRejections (internal/process/task_queues.js:82:21) {
reason: undefined,
statusCode: 301,
json: <Buffer >
}
2021-12-06T17:53:01+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T17:53:01+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T18:06:11+0100 <info> calendar.requests.js:52 () CalDAV : Found calendar tony.cuny@gmail.com
2021-12-06T18:06:11+0100 <info> calendar.requests.js:52 () CalDAV : Found calendar Jours fériés en France
2021-12-06T18:06:11+0100 <info> calendar.requests.js:52 () CalDAV : Found calendar Contacts
2021-12-06T18:06:11+0100 <info> calendar.syncUserCalendars.js:38 (CalDAVHandler.syncUserCalendars) CalDAV : Found 3 calendars.
2021-12-06T18:36:11+0100 <info> calendar.requests.js:52 () CalDAV : Found calendar tony.cuny@gmail.com
2021-12-06T18:36:11+0100 <info> calendar.requests.js:52 () CalDAV : Found calendar Jours fériés en France
2021-12-06T18:36:11+0100 <info> calendar.requests.js:52 () CalDAV : Found calendar Contacts
2021-12-06T18:36:11+0100 <info> calendar.syncUserCalendars.js:38 (CalDAVHandler.syncUserCalendars) CalDAV : Found 3 calendars.
2021-12-06T18:36:12+0100 <info> device.calculateAggregate.js:38 (DeviceManager.calculateAggregate) Calculating aggregates device feature state for interval hourly
2021-12-06T18:36:17+0100 <info> device.calculateAggregate.js:105 (ChildProcess.<anonymous>) device.calculateAggregate: Finishing processing for interval hourly
2021-12-06T18:36:17+0100 <info> device.calculateAggregate.js:38 (DeviceManager.calculateAggregate) Calculating aggregates device feature state for interval daily
2021-12-06T18:36:22+0100 <info> device.calculateAggregate.js:105 (ChildProcess.<anonymous>) device.calculateAggregate: Finishing processing for interval daily
2021-12-06T18:36:23+0100 <info> device.calculateAggregate.js:38 (DeviceManager.calculateAggregate) Calculating aggregates device feature state for interval monthly
2021-12-06T18:36:28+0100 <info> device.calculateAggregate.js:105 (ChildProcess.<anonymous>) device.calculateAggregate: Finishing processing for interval monthly
2021-12-06T18:41:05+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T18:41:05+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T18:41:43+0100 <error> index.js:20 (process.<anonymous>) uncaughtException catched: uncaughtException
2021-12-06T18:41:43+0100 <error> index.js:21 (process.<anonymous>) Error: getaddrinfo ENOTFOUND containers
at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
errno: -3008,
code: 'ENOTFOUND',
syscall: 'getaddrinfo',
hostname: 'containers'
}
2021-12-06T18:58:12+0100 <info> scene.actions.js:240 (Object.user.check-presence) CheckUserPresence action: No devices of the user "tony" were seen in the last 5 minutes.
2021-12-06T18:58:12+0100 <info> scene.actions.js:243 (Object.user.check-presence) CheckUserPresence action: Set "tony" to left home of house "my-home"
2021-12-06T18:58:12+0100 <warn> scene.actions.js:58 () ServiceNotConfiguredError
at MqttHandler.setValue (/src/server/services/mqtt/lib/setValue.js:19:11)
at DeviceManager.setValue (/src/server/lib/device/device.setValue.js:21:24)
at /src/server/lib/scene/scene.actions.js:56:27
at tryCatcher (/src/server/node_modules/bluebird/js/release/util.js:16:23)
at MappingPromiseArray._promiseFulfilled (/src/server/node_modules/bluebird/js/release/map.js:68:38)
at MappingPromiseArray.PromiseArray._iterate (/src/server/node_modules/bluebird/js/release/promise_array.js:115:31)
at MappingPromiseArray.init (/src/server/node_modules/bluebird/js/release/promise_array.js:79:10)
at MappingPromiseArray._asyncInit (/src/server/node_modules/bluebird/js/release/map.js:37:10)
at _drainQueueStep (/src/server/node_modules/bluebird/js/release/async.js:97:12)
at _drainQueue (/src/server/node_modules/bluebird/js/release/async.js:86:9)
at Async._drainQueues (/src/server/node_modules/bluebird/js/release/async.js:102:5)
at Immediate.Async.drainQueues (/src/server/node_modules/bluebird/js/release/async.js:15:14)
at processImmediate (internal/timers.js:464:21) {
message: undefined
}
2021-12-06T19:00:12+0100 <info> scene.actions.js:240 (Object.user.check-presence) CheckUserPresence action: No devices of the user "tony" were seen in the last 5 minutes.
2021-12-06T19:00:12+0100 <info> scene.actions.js:243 (Object.user.check-presence) CheckUserPresence action: Set "tony" to left home of house "my-home"
2021-12-06T19:02:12+0100 <info> scene.actions.js:240 (Object.user.check-presence) CheckUserPresence action: No devices of the user "tony" were seen in the last 5 minutes.