Nov 02 11:57:05 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:05+01:00" level=trace msg="sent dealer ping" Nov 02 11:57:05 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:05+01:00" level=trace msg="received dealer pong" Nov 02 11:57:27 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:27+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 282" Nov 02 11:57:28 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:28+01:00" level=debug msg="skipping dealer message" uri="hm://playlist/v2/playlist/4864t8Y6cXXQunYA9UKmQb" Nov 02 11:57:32 volumio4-rpi3-rasptouch volumio[25256]: info: CALLMETHOD: music_service ytcr configSaveConnection [object Object] Nov 02 11:57:32 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::executeOnPlugin: ytcr , configSaveConnection Nov 02 11:57:35 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:35+01:00" level=trace msg="sent dealer ping" Nov 02 11:57:35 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:35+01:00" level=trace msg="received dealer pong" Nov 02 11:57:41 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 11:57:41 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: warn: [yt-cast-receiver] stop() called but receiver not in RUNNING state. Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to stop receiver: Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: (TypeError) The "listener" argument must be of type function. Received undefined Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at checkListener (node:events:274:3) Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at Playlist.removeListener (node:events:677:7) Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at /data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:248:24 Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at Array.forEach () Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at MPDPlayer.destroy (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:247:64) Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: at async /data/plugins/music_service/ytcr/dist/index.js:435:13 Nov 02 11:57:50 volumio4-rpi3-rasptouch volumio[25256]: info: Error: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:57:53 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:53+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 282" Nov 02 11:57:53 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:57:53+01:00" level=debug msg="skipping dealer message" uri="hm://playlist/v2/playlist/4864t8Y6cXXQunYA9UKmQb" Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: warn: [yt-cast-receiver] stop() called but receiver not in RUNNING state. Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to stop receiver: Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: (TypeError) The "listener" argument must be of type function. Received undefined Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at checkListener (node:events:274:3) Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at Playlist.removeListener (node:events:677:7) Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at /data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:248:24 Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at Array.forEach () Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at MPDPlayer.destroy (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:247:64) Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: at async /data/plugins/music_service/ytcr/dist/index.js:435:13 Nov 02 11:57:53 volumio4-rpi3-rasptouch volumio[25256]: info: Error: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:57:56 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 11:58:00 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 02 11:58:00 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 02 11:58:00 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 02 11:58:05 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:58:05+01:00" level=trace msg="sent dealer ping" Nov 02 11:58:05 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:58:05+01:00" level=trace msg="received dealer pong" Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: info: Starting Uninstall of plugin music_service - ytcr Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: info: Uninstalling plugin ytcr Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: warn: [yt-cast-receiver] stop() called but receiver not in RUNNING state. Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to stop receiver: Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: (TypeError) The "listener" argument must be of type function. Received undefined Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at checkListener (node:events:274:3) Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at Playlist.removeListener (node:events:677:7) Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at /data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:248:24 Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at Array.forEach () Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at MPDPlayer.destroy (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:247:64) Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 02 11:58:09 volumio4-rpi3-rasptouch volumio[25256]: at async /data/plugins/music_service/ytcr/dist/index.js:435:13 Nov 02 11:58:20 volumio4-rpi3-rasptouch volumio[25256]: info: Enabling plugin ytcr Nov 02 11:58:20 volumio4-rpi3-rasptouch volumio[25256]: info: Loading plugin "ytcr"... Nov 02 11:58:20 volumio4-rpi3-rasptouch volumio[25256]: info: PLUGIN START: ytcr Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: error: [yt-cast-receiver] Failed to start receiver: Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: (DialServerError) Failed to start DIAL server Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: --->(Error) listen EADDRINUSE: address already in use :::8098 Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: Stack trace: Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: DialServerError: Failed to start DIAL server Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at Server. (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/dial/DialServer.js:103:28) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at Server.emit (node:events:514:28) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at emitErrorNT (node:net:1899:8) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: info: [yt-cast-receiver] Player.reset() Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: info: CoreCommandRouter::volumioGetState Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: info: CorePlayQueue::getTrack 0 Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to start plugin: Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: (DialServerError) Failed to start DIAL server Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: --->(Error) listen EADDRINUSE: address already in use :::8098 Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: Stack trace: Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: DialServerError: Failed to start DIAL server Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at Server. (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/dial/DialServer.js:103:28) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at Server.emit (node:events:514:28) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at emitErrorNT (node:net:1899:8) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Nov 02 11:58:21 volumio4-rpi3-rasptouch volumio[25256]: info: Done. Nov 02 11:58:24 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:58:24+01:00" level=trace msg="received accesspoint ping" Nov 02 11:58:25 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:58:25+01:00" level=trace msg="received accesspoint pong ack" Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: info: Starting Uninstall of plugin music_service - ytcr Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: info: Uninstalling plugin ytcr Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: warn: [yt-cast-receiver] stop() called but receiver not in RUNNING state. Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to stop receiver: Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: (TypeError) The "listener" argument must be of type function. Received undefined Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at checkListener (node:events:274:3) Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at Playlist.removeListener (node:events:677:7) Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at /data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:248:24 Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at Array.forEach () Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at MPDPlayer.destroy (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:247:64) Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 02 11:58:28 volumio4-rpi3-rasptouch volumio[25256]: at async /data/plugins/music_service/ytcr/dist/index.js:435:13 Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: warn: [yt-cast-receiver] stop() called but receiver not in RUNNING state. Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to stop receiver: Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: (TypeError) The "listener" argument must be of type function. Received undefined Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at checkListener (node:events:274:3) Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at Playlist.removeListener (node:events:677:7) Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at /data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:248:24 Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at Array.forEach () Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at MPDPlayer.destroy (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:247:64) Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: at async /data/plugins/music_service/ytcr/dist/index.js:435:13 Nov 02 11:58:33 volumio4-rpi3-rasptouch volumio[25256]: info: Error: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:58:35 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:58:35+01:00" level=trace msg="sent dealer ping" Nov 02 11:58:35 volumio4-rpi3-rasptouch go-librespot[25580]: time="2025-11-02T11:58:35+01:00" level=trace msg="received dealer pong" Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: info: Starting Uninstall of plugin music_service - ytcr Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: info: Uninstalling plugin ytcr Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: warn: [yt-cast-receiver] stop() called but receiver not in RUNNING state. Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: error: [ytcr] Failed to stop receiver: Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: (TypeError) The "listener" argument must be of type function. Received undefined Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: TypeError [ERR_INVALID_ARG_TYPE]: The "listener" argument must be of type function. Received undefined Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at checkListener (node:events:274:3) Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at Playlist.removeListener (node:events:677:7) Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at /data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:248:24 Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at Array.forEach () Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at MPDPlayer.destroy (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:247:64) Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Nov 02 11:58:38 volumio4-rpi3-rasptouch volumio[25256]: at async /data/plugins/music_service/ytcr/dist/index.js:435:13 Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: info: PLUGIN onReboot : networkfs Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: info: PLUGIN onReboot : audiophonicsonoff Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: TypeError: Cannot read properties of undefined (reading 'writeSync') Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_hardware/audiophonicsonoff/index.js:40:25) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:870:33) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at Socket.emit (node:events:514:28) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Nov 02 11:58:52 volumio4-rpi3-rasptouch volumio[25256]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 11:58:55 volumio4-rpi3-rasptouch sudo[25838]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-02 11:57' Nov 02 11:58:55 volumio4-rpi3-rasptouch sudo[25838]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="c22b72a8acb34a699a626adb0a09a6b88ee7233a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="40400d6a6fa57cf20e36499e510876b3654e9c4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Oct 4 16:40:08 UTC 2025" VOLUMIO_VERSION="4.061" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="7f8ace80645f85765fa10c72d1769d04"