-- Logs begin at Thu 2024-11-21 14:06:47 +07, end at Tue 2025-01-14 15:24:42 +07. -- Jan 14 15:24:26 volumio systemd[1]: Starting Daily apt download activities... Jan 14 15:24:27 volumio systemd[1]: Starting Daily man-db regeneration... Jan 14 15:24:28 volumio systemd[1]: man-db.service: Succeeded. Jan 14 15:24:28 volumio systemd[1]: Started Daily man-db regeneration. Jan 14 15:24:28 volumio systemd-journald[418]: Suppressed 21164 messages from volumio.service Jan 14 15:24:28 volumio volumio[989]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 14 15:24:28 volumio volumio[989]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 14 15:24:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 15:24:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 15:24:28 volumio volumio[989]: info: Starting MyVolumio Remote Streaming Endpoints Jan 14 15:24:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 14 15:24:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Jan 14 15:24:28 volumio systemd[1]: Stopped go-librespot Daemon. Jan 14 15:24:28 volumio volumio[989]: info: MyVolumio login type: Token Jan 14 15:24:28 volumio systemd[1]: Started go-librespot Daemon. Jan 14 15:24:28 volumio go-librespot[2345]: Librespot-go daemon starting... Jan 14 15:24:29 volumio go-librespot[2345]: time="2025-01-14T15:24:29+07:00" level=info msg="generated new device id: 30020664724dc359f544274785118554028f0d82" Jan 14 15:24:29 volumio volumio[989]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 14 15:24:29 volumio volumio[989]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 14 15:24:30 volumio go-librespot[2345]: time="2025-01-14T15:24:30+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Jan 14 15:24:30 volumio go-librespot[2345]: time="2025-01-14T15:24:30+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Jan 14 15:24:30 volumio go-librespot[2345]: time="2025-01-14T15:24:30+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jan 14 15:24:30 volumio go-librespot[2345]: time="2025-01-14T15:24:30+07:00" level=debug msg="zeroconf server listening on port 39379" Jan 14 15:24:32 volumio systemd[1]: apt-daily.service: Succeeded. Jan 14 15:24:32 volumio systemd[1]: Started Daily apt download activities. Jan 14 15:24:32 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jan 14 15:24:36 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 14 15:24:36 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jan 14 15:24:37 volumio volumio[989]: info: Starting Streaming Service Transparent Proxy Jan 14 15:24:37 volumio volumio[989]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 14 15:24:37 volumio volumio[989]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 14 15:24:37 volumio volumio[989]: info: Streaming services startup Jan 14 15:24:37 volumio volumio[989]: info: Starting Streaming Daemon Jan 14 15:24:37 volumio sudo[2476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 14 15:24:37 volumio sudo[2476]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 15:24:37 volumio volumio[989]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 14 15:24:37 volumio sudo[2476]: pam_unix(sudo:session): session closed for user root Jan 14 15:24:38 volumio volumio[989]: info: Initializing connection to go-librespot Websocket Jan 14 15:24:38 volumio volumio[989]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Jan 14 15:24:38 volumio volumio[989]: LoungeScreenDisconnected { Jan 14 15:24:38 volumio volumio[989]: AID: null, Jan 14 15:24:38 volumio volumio[989]: name: 'loungeScreenDisconnected', Jan 14 15:24:38 volumio volumio[989]: payload: {} Jan 14 15:24:38 volumio volumio[989]: } Jan 14 15:24:38 volumio volumio[989]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Jan 14 15:24:38 volumio volumio[989]: Stack trace: Jan 14 15:24:38 volumio volumio[989]: IncompleteAPIDataError: Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Jan 14 15:24:38 volumio volumio[989]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Jan 14 15:24:38 volumio volumio[989]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Jan 14 15:24:38 volumio volumio[989]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Jan 14 15:24:38 volumio volumio[989]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Jan 14 15:24:38 volumio volumio[989]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) 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: 21929) Jan 14 15:24:38 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 14 15:24:38 volumio volumio[989]: info: Received Get System Info Jan 14 15:24:38 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 14 15:24:38 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 14 15:24:38 volumio volumio[989]: info: Discovery: Getting this device information Jan 14 15:24:38 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Jan 14 15:24:38 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Jan 14 15:24:38 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 14 15:24:38 volumio volumio[989]: error: Cannot start Volumio Streaming Daemon Jan 14 15:24:38 volumio volumio[989]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 14 15:24:38 volumio volumio[989]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 14 15:24:38 volumio volumio[989]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Jan 14 15:24:38 volumio volumio[989]: LoungeScreenDisconnected { Jan 14 15:24:38 volumio volumio[989]: AID: null, Jan 14 15:24:38 volumio volumio[989]: name: 'loungeScreenDisconnected', Jan 14 15:24:38 volumio volumio[989]: payload: {} Jan 14 15:24:38 volumio volumio[989]: } Jan 14 15:24:38 volumio volumio[989]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Jan 14 15:24:38 volumio volumio[989]: Stack trace: Jan 14 15:24:38 volumio volumio[989]: IncompleteAPIDataError: Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Jan 14 15:24:38 volumio volumio[989]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Jan 14 15:24:38 volumio volumio[989]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Jan 14 15:24:38 volumio volumio[989]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Jan 14 15:24:38 volumio volumio[989]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Jan 14 15:24:38 volumio volumio[989]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) 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: 21931) Jan 14 15:24:38 volumio volumio[989]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Jan 14 15:24:38 volumio volumio[989]: LoungeScreenDisconnected { Jan 14 15:24:38 volumio volumio[989]: AID: null, Jan 14 15:24:38 volumio volumio[989]: name: 'loungeScreenDisconnected', Jan 14 15:24:38 volumio volumio[989]: payload: {} Jan 14 15:24:38 volumio volumio[989]: } Jan 14 15:24:38 volumio volumio[989]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Jan 14 15:24:38 volumio volumio[989]: Stack trace: Jan 14 15:24:38 volumio volumio[989]: IncompleteAPIDataError: Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Jan 14 15:24:38 volumio volumio[989]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Jan 14 15:24:38 volumio volumio[989]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Jan 14 15:24:38 volumio volumio[989]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Jan 14 15:24:38 volumio volumio[989]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Jan 14 15:24:38 volumio volumio[989]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) 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: 21933) Jan 14 15:24:38 volumio volumio[989]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Jan 14 15:24:38 volumio volumio[989]: LoungeScreenDisconnected { Jan 14 15:24:38 volumio volumio[989]: AID: null, Jan 14 15:24:38 volumio volumio[989]: name: 'loungeScreenDisconnected', Jan 14 15:24:38 volumio volumio[989]: payload: {} Jan 14 15:24:38 volumio volumio[989]: } Jan 14 15:24:38 volumio volumio[989]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Jan 14 15:24:38 volumio volumio[989]: Stack trace: Jan 14 15:24:38 volumio volumio[989]: IncompleteAPIDataError: Missing data required to construct query string from bind params Jan 14 15:24:38 volumio volumio[989]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Jan 14 15:24:38 volumio volumio[989]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Jan 14 15:24:38 volumio volumio[989]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Jan 14 15:24:38 volumio volumio[989]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Jan 14 15:24:38 volumio volumio[989]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Jan 14 15:24:38 volumio volumio[989]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Jan 14 15:24:38 volumio volumio[989]: at runMicrotasks () Jan 14 15:24:38 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 14 15:24:38 volumio volumio[989]: (node:989) 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: 21935) Jan 14 15:24:38 volumio volumio[989]: info: Discovery: A device disappeared from network Jan 14 15:24:38 volumio volumio[989]: info: Discovery: Device volumio disappeared from network Jan 14 15:24:39 volumio go-librespot[2345]: time="2025-01-14T15:24:39+07:00" level=debug msg="new websocket client" Jan 14 15:24:39 volumio volumio[989]: info: Connection to go-librespot Websocket established Jan 14 15:24:39 volumio volumio[989]: error: MyVolumio Custom Token format not valid, refreshing it Jan 14 15:24:39 volumio volumio[989]: info: Discovery: adding c1f317b2-190e-4ec5-a12f-aeaf92f0ea6a Jan 14 15:24:39 volumio volumio[989]: info: Discovery: Found device Volumio Jan 14 15:24:39 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Jan 14 15:24:39 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Jan 14 15:24:39 volumio volumio[989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 14 15:24:39 volumio volumio[989]: Error: The value NaN is not a number Jan 14 15:24:39 volumio volumio[989]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Jan 14 15:24:39 volumio volumio[989]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Jan 14 15:24:39 volumio volumio[989]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Jan 14 15:24:39 volumio volumio[989]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Jan 14 15:24:39 volumio volumio[989]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Jan 14 15:24:39 volumio volumio[989]: at Browser.emit (events.js:400:28) Jan 14 15:24:39 volumio volumio[989]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jan 14 15:24:39 volumio volumio[989]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jan 14 15:24:39 volumio volumio[989]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Jan 14 15:24:39 volumio volumio[989]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Jan 14 15:24:39 volumio volumio[989]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jan 14 15:24:39 volumio volumio[989]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jan 14 15:24:39 volumio volumio[989]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jan 14 15:24:39 volumio volumio[989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 14 15:24:42 volumio sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-14 15:23 Jan 14 15:24:42 volumio sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 09:45:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="bananapim1" VOLUMIO_DEVICENAME="BananaPi M1" VOLUMIO_HASH="89d82fddc741ef0aa74780c3c7a7d849"