-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-08-23 20:08:46 CEST. -- Aug 23 20:07:17 myvolumio volumio[940]: info: Tunnel connection is inactive, restarting it Aug 23 20:07:17 myvolumio volumio[940]: info: Starting Tunnel 1 Aug 23 20:07:17 myvolumio volumio[940]: info: Starting Tunnel Connection Checker Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 20:07:18 myvolumio volumio[940]: info: Discovery: Getting this device information Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::volumioGetState Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 20:07:20 myvolumio sudo[13067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Aug 23 20:07:20 myvolumio sudo[13067]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:07:20 myvolumio autossh[12594]: received signal to exit (15) Aug 23 20:07:20 myvolumio systemd[1]: Stopping MyVolumio SSH Tunnel... Aug 23 20:07:20 myvolumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Aug 23 20:07:20 myvolumio systemd[1]: sshtunnel.service: Succeeded. Aug 23 20:07:20 myvolumio systemd[1]: Stopped MyVolumio SSH Tunnel. Aug 23 20:07:20 myvolumio volumio[940]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 23 20:07:20 myvolumio volumio[940]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 23 20:07:20 myvolumio systemd[1]: Started MyVolumio SSH Tunnel. Aug 23 20:07:20 myvolumio sudo[13067]: pam_unix(sudo:session): session closed for user root Aug 23 20:07:20 myvolumio autossh[13070]: port set to 0, monitoring disabled Aug 23 20:07:20 myvolumio autossh[13070]: starting ssh (count 1) Aug 23 20:07:20 myvolumio autossh[13070]: ssh child pid is 13073 Aug 23 20:07:20 myvolumio volumio[940]: info: Remote SSH Started Aug 23 20:07:20 myvolumio volumio[940]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10 Aug 23 20:07:21 myvolumio volumio[940]: info: CoreCommandRouter::volumioGetState Aug 23 20:07:21 myvolumio volumiossh-tunnel[13069]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Aug 23 20:07:21 myvolumio volumiossh-tunnel[13069]: Warning: remote port forwarding failed for listen port 8091 Aug 23 20:07:23 myvolumio volumio-remote-updater[537]: zsync done Aug 23 20:07:23 myvolumio volumio-remote-updater[537]: PROGRESS: 80, STATUS: "Downloading new update", ETA: "2m" Aug 23 20:07:23 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:23 myvolumio volumio[940]: updateProgress Aug 23 20:07:23 myvolumio volumio[940]: { Aug 23 20:07:23 myvolumio volumio[940]: downloadSpeed: '', Aug 23 20:07:23 myvolumio volumio[940]: eta: '2m', Aug 23 20:07:23 myvolumio volumio[940]: progress: 80, Aug 23 20:07:23 myvolumio volumio[940]: status: 'Neue Aktualisierung wird heruntergeladen' Aug 23 20:07:23 myvolumio volumio[940]: } Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 20:07:48 myvolumio volumio[940]: info: Discovery: Getting this device information Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::volumioGetState Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: zsync done Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: PROGRESS: 90, STATUS: "Cleaning old files", ETA: "1m" Aug 23 20:07:55 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:55 myvolumio volumio[940]: updateProgress Aug 23 20:07:55 myvolumio volumio[940]: { Aug 23 20:07:55 myvolumio volumio[940]: downloadSpeed: '', Aug 23 20:07:55 myvolumio volumio[940]: eta: '1m', Aug 23 20:07:55 myvolumio volumio[940]: progress: 90, Aug 23 20:07:55 myvolumio volumio[940]: status: 'Alte Dateien werden bereinigt' Aug 23 20:07:55 myvolumio volumio[940]: } Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: /bin/cp: cannot stat '/data/volumio_factory.sqsh': No such file or directory Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s" Aug 23 20:07:55 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:55 myvolumio volumio[940]: updateProgress Aug 23 20:07:55 myvolumio volumio[940]: { Aug 23 20:07:55 myvolumio volumio[940]: downloadSpeed: '', Aug 23 20:07:55 myvolumio volumio[940]: eta: '30s', Aug 23 20:07:55 myvolumio volumio[940]: progress: 95, Aug 23 20:07:55 myvolumio volumio[940]: status: 'Aktualisierung wird abgeschlossen' Aug 23 20:07:55 myvolumio volumio[940]: } Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.742\" version. System restart required." Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: No test mode Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: No alpha test mode Aug 23 20:07:56 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:56 myvolumio volumio[940]: updateReady Aug 23 20:07:56 myvolumio volumio-remote-updater[537]: [2024-08-23 20:07:56] [disconnect] Disconnect close local:[1000] remote:[1000] Aug 23 20:07:56 myvolumio volumio-remote-updater[537]: [2024-08-23 20:07:56] [info] asio async_write error: system:32 (Broken pipe) Aug 23 20:07:56 myvolumio volumio-remote-updater[537]: [2024-08-23 20:07:56] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error) Aug 23 20:07:56 myvolumio volumio[940]: { Aug 23 20:07:56 myvolumio volumio[940]: changeLogLink: 'http://volumio.org', Aug 23 20:07:56 myvolumio volumio[940]: description: '

FIXES



NEW ADDITIONS

 

', Aug 23 20:07:56 myvolumio volumio[940]: title: 'Update v3.742', Aug 23 20:07:56 myvolumio volumio[940]: updateavailable: true Aug 23 20:07:56 myvolumio volumio[940]: } Aug 23 20:07:56 myvolumio systemd[1]: volumio-remote-updater.service: Succeeded. Aug 23 20:07:56 myvolumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart. Aug 23 20:07:56 myvolumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1. Aug 23 20:07:56 myvolumio systemd[1]: Stopped volumio-remote-updater.service. Aug 23 20:07:56 myvolumio systemd[1]: Started volumio-remote-updater.service. Aug 23 20:07:56 myvolumio volumio-remote-updater[13167]: Error: No active session Aug 23 20:07:56 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:07:56] [connect] Successful connection Aug 23 20:07:56 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:07:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724436476 101 Aug 23 20:07:56 myvolumio volumio[940]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 10 Aug 23 20:07:56 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:57 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:58 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:07:59 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:00 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:01 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:02 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:03 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:04 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:05 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:06 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:07 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:08 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:09 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:10 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Aug 23 20:08:11 myvolumio volumio[940]: info: CoreCommandRouter::Close All Modals sent Aug 23 20:08:11 myvolumio volumio[940]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 23 20:08:11 myvolumio volumio[940]: info: PLUGIN onReboot : networkfs Aug 23 20:08:11 myvolumio sudo[13205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/Roger Aug 23 20:08:12 myvolumio sudo[13205]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:12 myvolumio sudo[13205]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:12 myvolumio volumio[940]: umount: /mnt/NAS/Roger: not mounted. Aug 23 20:08:12 myvolumio volumio[940]: error: Cannot umount share Roger : Error: Command failed: /usr/bin/sudo /bin/umount -f /mnt/NAS/Roger Aug 23 20:08:12 myvolumio volumio[940]: umount: /mnt/NAS/Roger: not mounted. Aug 23 20:08:12 myvolumio volumio[940]: info: PLUGIN onReboot : audiophonicsonoff Aug 23 20:08:12 myvolumio volumio[940]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 20:08:12 myvolumio volumio[940]: TypeError: Cannot read property 'writeSync' of undefined Aug 23 20:08:12 myvolumio volumio[940]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Aug 23 20:08:12 myvolumio volumio[940]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Aug 23 20:08:12 myvolumio volumio[940]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Aug 23 20:08:12 myvolumio volumio[940]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 23 20:08:12 myvolumio volumio[940]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 23 20:08:12 myvolumio volumio[940]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Aug 23 20:08:12 myvolumio volumio[940]: at CoreCommandRouter.reboot (/volumio/app/index.js:1324:22) Aug 23 20:08:12 myvolumio volumio[940]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/updater_comm/index.js:156:35) Aug 23 20:08:12 myvolumio volumio[940]: at listOnTimeout (internal/timers.js:554:17) Aug 23 20:08:12 myvolumio volumio[940]: at processTimers (internal/timers.js:497:7) Aug 23 20:08:12 myvolumio volumio[940]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 20:08:12 myvolumio sudo[13216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 20:07 Aug 23 20:08:12 myvolumio sudo[13216]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:12 myvolumio sudo[13216]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:12 myvolumio vtcs[1741]: [2024-08-23 20:08:12.762] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Aug 23 20:08:12 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:08:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 23 20:08:12 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:08:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 23 20:08:12 myvolumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 23 20:08:12 myvolumio systemd[1]: media-Expansion.mount: Succeeded. Aug 23 20:08:13 myvolumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 23 20:08:13 myvolumio systemd[1]: Started dynamicswap service. Aug 23 20:08:13 myvolumio systemd[1]: dynamicswap.service: Succeeded. Aug 23 20:08:13 myvolumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 23 20:08:13 myvolumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Aug 23 20:08:13 myvolumio systemd[1]: Started dynamicswap service. Aug 23 20:08:13 myvolumio systemd[1]: Stopped Volumio Backend Module. Aug 23 20:08:13 myvolumio systemd[1]: Started Volumio Backend Module. Aug 23 20:08:13 myvolumio systemd[1]: dynamicswap.service: Succeeded. Aug 23 20:08:13 myvolumio systemd[1]: upmpdcli.service: Succeeded. Aug 23 20:08:14 myvolumio volumio[13232]: info: ------------------------------------------- Aug 23 20:08:14 myvolumio volumio[13232]: info: ----- Volumio3 ---- Aug 23 20:08:14 myvolumio volumio[13232]: info: ------------------------------------------- Aug 23 20:08:14 myvolumio volumio[13232]: info: ----- System startup ---- Aug 23 20:08:14 myvolumio volumio[13232]: info: ------------------------------------------- Aug 23 20:08:14 myvolumio volumio[13232]: info: MYVOLUMIO Environment detected Aug 23 20:08:14 myvolumio volumio[13232]: info: Plugin folders cleanup Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning into folder /volumio/app/plugins/ Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category audio_interface Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category miscellanea Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category music_service Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category plugins.json Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category system_controller Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category user_interface Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning into folder /data/plugins/ Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category audio_interface Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category music_service Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category system_controller Aug 23 20:08:14 myvolumio volumio[13232]: info: Scanning category system_hardware Aug 23 20:08:14 myvolumio volumio[13232]: info: Plugin folders cleanup completed Aug 23 20:08:14 myvolumio volumio[13232]: info: ------------------------------------------- Aug 23 20:08:14 myvolumio volumio[13232]: info: ----- Core plugins startup ---- Aug 23 20:08:14 myvolumio volumio[13232]: info: ------------------------------------------- Aug 23 20:08:14 myvolumio volumio[13232]: info: Loading plugins from folder /volumio/app/plugins/ Aug 23 20:08:14 myvolumio volumio[13232]: info: Adding plugin upnp to MyMusic Plugins Aug 23 20:08:14 myvolumio volumio[13232]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 23 20:08:14 myvolumio volumio[13232]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 23 20:08:14 myvolumio volumio[13232]: info: Loading plugins from folder /data/plugins/ Aug 23 20:08:14 myvolumio volumio[13232]: info: Loading plugin "system"... Aug 23 20:08:14 myvolumio volumio[13232]: info: Loading plugin "appearance"... Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "network"... Aug 23 20:08:15 myvolumio volumio[13232]: info: Refreshing Cached IP Addresses Aug 23 20:08:15 myvolumio sudo[13255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 23 20:08:15 myvolumio sudo[13255]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:15 myvolumio sudo[13255]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:15 myvolumio sudo[13257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "services"... Aug 23 20:08:15 myvolumio sudo[13257]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "alsa_controller"... Aug 23 20:08:15 myvolumio sudo[13257]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:15 myvolumio sudo[13260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 23 20:08:15 myvolumio sudo[13260]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:15 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "wizard"... Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "volumio_command_line_client"... Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "upnp"... Aug 23 20:08:15 myvolumio volumio[13232]: info: [1724436495567] Starting Upmpd Daemon Aug 23 20:08:15 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "my_music"... Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "mpd"... Aug 23 20:08:15 myvolumio volumio[13232]: info: Creating MPD Configuration file Aug 23 20:08:15 myvolumio sudo[13268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "upnp_browser"... Aug 23 20:08:15 myvolumio sudo[13268]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:15 myvolumio sudo[13268]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:15 myvolumio sudo[13270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 23 20:08:15 myvolumio sudo[13270]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:15 myvolumio systemd[1]: Stopping Music Player Daemon... Aug 23 20:08:15 myvolumio volumio[13232]: info: Loading plugin "networkfs"... Aug 23 20:08:16 myvolumio volumio[13232]: info: Starting Udev Watcher for removable devices Aug 23 20:08:16 myvolumio sudo[13275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.101/Roger und Joys WLAN-Netzwerk /mnt/NAS/Roger Aug 23 20:08:16 myvolumio sudo[13275]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:16 myvolumio kernel: CIFS: Attempting to mount \\192.168.1.101\Roger und Joys WLAN-Netzwerk Aug 23 20:08:16 myvolumio volumio[13232]: info: Ignoring mount for partition: boot Aug 23 20:08:16 myvolumio volumio[13232]: info: Ignoring mount for partition: volumio Aug 23 20:08:16 myvolumio volumio[13232]: info: Ignoring mount for partition: volumio_data Aug 23 20:08:16 myvolumio volumio[13232]: info: Mounting Device EFI Aug 23 20:08:16 myvolumio sudo[13284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 23 20:08:16 myvolumio sudo[13284]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:16 myvolumio sudo[13275]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:16 myvolumio sudo[13284]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:16 myvolumio volumio[13232]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Aug 23 20:08:16 myvolumio volumio[13232]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 23 20:08:16 myvolumio volumio[13232]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Aug 23 20:08:16 myvolumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Aug 23 20:08:16 myvolumio kernel: CIFS: VFS: \\192.168.1.101 Send error in SessSetup = -13 Aug 23 20:08:16 myvolumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 23 20:08:16 myvolumio volumio[13232]: info: Mounting Device Expansion Aug 23 20:08:16 myvolumio sudo[13290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Expansion -o noatime Aug 23 20:08:16 myvolumio sudo[13290]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:16 myvolumio sudo[13290]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:16 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "alarm-clock"... Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "airplay_emulation"... Aug 23 20:08:16 myvolumio volumio[13232]: info: Starting Shairport Sync Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "last_100"... Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "webradio"... Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "i2s_dacs"... Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "volumiodiscovery"... Aug 23 20:08:16 myvolumio volumio[13232]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 23 20:08:16 myvolumio volumio[13232]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 23 20:08:16 myvolumio node[13232]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 23 20:08:16 myvolumio volumio[13232]: *** WARNING *** For more information see Aug 23 20:08:16 myvolumio volumio[13232]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 23 20:08:16 myvolumio volumio[13232]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 23 20:08:16 myvolumio volumio[13232]: *** WARNING *** For more information see Aug 23 20:08:16 myvolumio node[13232]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 23 20:08:16 myvolumio node[13232]: *** WARNING *** For more information see Aug 23 20:08:16 myvolumio node[13232]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 23 20:08:16 myvolumio node[13232]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 23 20:08:16 myvolumio node[13232]: *** WARNING *** For more information see Aug 23 20:08:16 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 23 20:08:16 myvolumio volumio[13232]: info: Discovery: Started advertising with name: MyVolumio Aug 23 20:08:16 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 23 20:08:16 myvolumio volumio[13232]: info: Loading plugin "soundcloud"... Aug 23 20:08:17 myvolumio volumio[13232]: info: Loading plugin "youtube2"... Aug 23 20:08:17 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:08:17] [connect] Successful connection Aug 23 20:08:17 myvolumio volumio[13232]: info: Loading plugin "ytcr"... Aug 23 20:08:18 myvolumio sudo[13260]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:18 myvolumio volumio[13232]: info: Loading plugin "ytmusic"... Aug 23 20:08:19 myvolumio volumio[13232]: info: Loading plugin "autostart"... Aug 23 20:08:19 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin autostart Aug 23 20:08:19 myvolumio volumio[13232]: info: AutoStart - onVolumioStart - read config.json Aug 23 20:08:19 myvolumio volumio[13232]: info: Loading plugin "gpio-buttons"... Aug 23 20:08:19 myvolumio volumio[13232]: info: GPIO-Buttons initialized Aug 23 20:08:19 myvolumio volumio[13232]: info: Loading plugin "outputs"... Aug 23 20:08:19 myvolumio volumio[13232]: info: Loading plugin "albumart"... Aug 23 20:08:19 myvolumio volumio[13232]: info: Plugin example_plugin is not enabled Aug 23 20:08:19 myvolumio volumio[13232]: info: Loading plugin "inputs"... Aug 23 20:08:19 myvolumio volumio[13232]: info: Loading plugin "updater_comm"... Aug 23 20:08:20 myvolumio volumio[13232]: info: Plugin mpdemulation is not enabled Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "rest_api"... Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "websocket"... Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "fusiondsp"... Aug 23 20:08:20 myvolumio volumio[13232]: Forking 3 albumart workers Aug 23 20:08:20 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin fusiondsp Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "80s80s"... Aug 23 20:08:20 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin 80s80s Aug 23 20:08:20 myvolumio volumio[13232]: info: [1724436500502] [80s80s] API delay: 30 Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "RoonBridge"... Aug 23 20:08:20 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin RoonBridge Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "radio_paradise"... Aug 23 20:08:20 myvolumio volumio[13232]: Starting albumart workers Aug 23 20:08:20 myvolumio volumio[13232]: Starting albumart workers Aug 23 20:08:20 myvolumio volumio[13232]: Starting albumart workers Aug 23 20:08:20 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin radio_paradise Aug 23 20:08:20 myvolumio volumio[13232]: info: [1724436500840] [RadioParadise] API delay: 5 Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "audiophonicsonoff"... Aug 23 20:08:20 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin audiophonicsonoff Aug 23 20:08:20 myvolumio volumio[13232]: info: Audiophonics on/off initiated Aug 23 20:08:20 myvolumio volumio[13232]: info: Loading plugin "backup_restore"... Aug 23 20:08:21 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin backup_restore Aug 23 20:08:21 myvolumio volumio[13232]: info: Loading plugin "audiophonics_evo_sabre"... Aug 23 20:08:21 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Aug 23 20:08:21 myvolumio volumio[13232]: info: Loading plugin "onkyo_control"... Aug 23 20:08:21 myvolumio volumio[13232]: info: Applying required configuration parameters for plugin onkyo_control Aug 23 20:08:21 myvolumio volumio[13232]: info: Loading i18n strings for locale de Aug 23 20:08:21 myvolumio volumio[13232]: Updating browse sources language Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::initPlayerControls Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 20:08:21 myvolumio volumio[13232]: Express server listening on port 3000 Aug 23 20:08:21 myvolumio volumio[13232]: [Metrics] WebUI: 7s 497.46ms Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreStateMachine::resetVolumioState Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreStateMachine::getcurrentVolume Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::volumioRetrievevolume Aug 23 20:08:21 myvolumio volumio[13232]: info: Cannot mount NAS Roger at system boot, trial number 1 ,retrying in 5 seconds Aug 23 20:08:21 myvolumio volumio[13232]: info: MPD Permissions set Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 1 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 2 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27:3000 from 192.168.1.44 UA: Dart/3.4 (dart:io) Total Clients: 3 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 4 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 5 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 6 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 7 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 8 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 9 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 10 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 11 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 12 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 13 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 14 Aug 23 20:08:21 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:08:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724436497 101 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 15 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 16 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 17 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 18 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 19 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 20 Aug 23 20:08:21 myvolumio volumio[13232]: Unable to parse: Aug 23 20:08:21 myvolumio volumio[13232]: Simple mixer control 'PCM',0 Aug 23 20:08:21 myvolumio volumio[13232]: Capabilities: pswitch pswitch-joined Aug 23 20:08:21 myvolumio volumio[13232]: Playback channels: Mono Aug 23 20:08:21 myvolumio volumio[13232]: Mono: Playback [on] Aug 23 20:08:21 myvolumio volumio[13232]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 20:08:21 myvolumio volumio[13232]: info: Discovery: Getting this device information Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetState Aug 23 20:08:21 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:21 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 21 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 22 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 23 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 24 Aug 23 20:08:21 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.2.5 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 25 Aug 23 20:08:22 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Total Clients: 26 Aug 23 20:08:22 myvolumio volumio[13232]: verbose: New Socket.io Connection to 192.168.1.27 from 192.168.1.44 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 27 Aug 23 20:08:22 myvolumio volumio[13232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 28 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 23 20:08:22 myvolumio volumio[13232]: info: Reloading queue from file Aug 23 20:08:22 myvolumio volumio[13232]: Unable to parse: Aug 23 20:08:22 myvolumio volumio[13232]: Simple mixer control 'PCM',0 Aug 23 20:08:22 myvolumio volumio[13232]: Capabilities: pswitch pswitch-joined Aug 23 20:08:22 myvolumio volumio[13232]: Playback channels: Mono Aug 23 20:08:22 myvolumio volumio[13232]: Mono: Playback [on] Aug 23 20:08:22 myvolumio volumio[13232]: info: VolumeController:: Volume=undefined Mute =false Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::pushState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioPushState Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::updateTrackBlock Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrackBlock Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioRetrievevolume Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::setRepeat false single undefined Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::pushState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioPushState Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::setRandom true Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::pushState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioPushState Aug 23 20:08:22 myvolumio volumio[13232]: info: Setting Device type: Raspberry PI Aug 23 20:08:22 myvolumio volumio[13232]: Unable to parse: Aug 23 20:08:22 myvolumio volumio[13232]: Simple mixer control 'PCM',0 Aug 23 20:08:22 myvolumio volumio[13232]: Capabilities: pswitch pswitch-joined Aug 23 20:08:22 myvolumio volumio[13232]: Playback channels: Mono Aug 23 20:08:22 myvolumio volumio[13232]: Mono: Playback [on] Aug 23 20:08:22 myvolumio volumio[13232]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetVisibleSources Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetQueue Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::getQueue Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getQueue Aug 23 20:08:22 myvolumio volumio[13232]: info: Listing playlists Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: Unable to parse: Aug 23 20:08:22 myvolumio volumio[13232]: Simple mixer control 'PCM',0 Aug 23 20:08:22 myvolumio volumio[13232]: Capabilities: pswitch pswitch-joined Aug 23 20:08:22 myvolumio volumio[13232]: Playback channels: Mono Aug 23 20:08:22 myvolumio volumio[13232]: Mono: Playback [on] Aug 23 20:08:22 myvolumio volumio[13232]: info: VolumeController:: Volume=undefined Mute =false Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreStateMachine::pushState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioPushState Aug 23 20:08:22 myvolumio volumio[13232]: info: Discovery: adding f86d87e5-2c0f-4d5d-8654-75a26a77b8df Aug 23 20:08:22 myvolumio volumio[13232]: info: Discovery: Found device MyVolumio Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetVisibleSources Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 23 20:08:22 myvolumio volumio[13232]: info: Listing playlists Aug 23 20:08:22 myvolumio volumio[13232]: info: Discovery: this is already registered, f86d87e5-2c0f-4d5d-8654-75a26a77b8df Aug 23 20:08:22 myvolumio volumio[13232]: info: Discovery: Found device MyVolumio Aug 23 20:08:22 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetState Aug 23 20:08:22 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:23 myvolumio volumio[13232]: info: VolumeController::SetAlsaVolume0 Aug 23 20:08:23 myvolumio volumio[13232]: info: CoreStateMachine::pushState Aug 23 20:08:23 myvolumio volumio[13232]: info: CorePlayQueue::getTrack 0 Aug 23 20:08:23 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 20:08:23 myvolumio volumio[13232]: info: CoreCommandRouter::volumioPushState Aug 23 20:08:25 myvolumio sudo[13370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 23 20:08:25 myvolumio sudo[13370]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:25 myvolumio sudo[13370]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:25 myvolumio sudo[13373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 23 20:08:25 myvolumio sudo[13373]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:25 myvolumio sudo[13373]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:25 myvolumio sudo[13376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 23 20:08:25 myvolumio sudo[13376]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:25 myvolumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 23 20:08:25 myvolumio sudo[13376]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:25 myvolumio volumio[13232]: info: Upmpdcli Daemon Started Aug 23 20:08:26 myvolumio sudo[13380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.101/Roger und Joys WLAN-Netzwerk /mnt/NAS/Roger Aug 23 20:08:26 myvolumio sudo[13380]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:26 myvolumio kernel: CIFS: Attempting to mount \\192.168.1.101\Roger und Joys WLAN-Netzwerk Aug 23 20:08:26 myvolumio sudo[13380]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:26 myvolumio volumio[13232]: info: Cannot mount NAS Roger at system boot, trial number 2 ,retrying in 5 seconds Aug 23 20:08:26 myvolumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Aug 23 20:08:26 myvolumio kernel: CIFS: VFS: \\192.168.1.101 Send error in SessSetup = -13 Aug 23 20:08:26 myvolumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 23 20:08:31 myvolumio sudo[13386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.101/Roger und Joys WLAN-Netzwerk /mnt/NAS/Roger Aug 23 20:08:31 myvolumio sudo[13386]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:31 myvolumio kernel: CIFS: Attempting to mount \\192.168.1.101\Roger und Joys WLAN-Netzwerk Aug 23 20:08:31 myvolumio sudo[13386]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:31 myvolumio volumio[13232]: info: Cannot mount NAS Roger at system boot, trial number 3 ,retrying in 5 seconds Aug 23 20:08:31 myvolumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Aug 23 20:08:31 myvolumio kernel: CIFS: VFS: \\192.168.1.101 Send error in SessSetup = -13 Aug 23 20:08:31 myvolumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 23 20:08:37 myvolumio sudo[13394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.101/Roger und Joys WLAN-Netzwerk /mnt/NAS/Roger Aug 23 20:08:37 myvolumio sudo[13394]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:37 myvolumio kernel: CIFS: Attempting to mount \\192.168.1.101\Roger und Joys WLAN-Netzwerk Aug 23 20:08:37 myvolumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Aug 23 20:08:37 myvolumio kernel: CIFS: VFS: \\192.168.1.101 Send error in SessSetup = -13 Aug 23 20:08:37 myvolumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 23 20:08:37 myvolumio sudo[13394]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:37 myvolumio volumio[13232]: info: Cannot mount NAS Roger at system boot, trial number 4 ,retrying in 5 seconds Aug 23 20:08:42 myvolumio sudo[13401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.101/Roger und Joys WLAN-Netzwerk /mnt/NAS/Roger Aug 23 20:08:42 myvolumio sudo[13401]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 20:08:42 myvolumio kernel: CIFS: Attempting to mount \\192.168.1.101\Roger und Joys WLAN-Netzwerk Aug 23 20:08:42 myvolumio sudo[13401]: pam_unix(sudo:session): session closed for user root Aug 23 20:08:42 myvolumio volumio[13232]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 23 20:08:42 myvolumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Aug 23 20:08:42 myvolumio kernel: CIFS: VFS: \\192.168.1.101 Send error in SessSetup = -13 Aug 23 20:08:42 myvolumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 20:08:42 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 23 20:08:46 myvolumio volumio[13232]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 23 20:08:46 myvolumio volumio[13232]: verbose: ControllerMpd::sendMpdCommand update Aug 23 20:08:46 myvolumio volumio[13232]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 20:08:46 myvolumio volumio[13232]: TypeError: Cannot read property 'then' of undefined Aug 23 20:08:46 myvolumio volumio[13232]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) Aug 23 20:08:46 myvolumio volumio[13232]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1891:15) Aug 23 20:08:46 myvolumio volumio[13232]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1076:32) Aug 23 20:08:46 myvolumio volumio[13232]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26) Aug 23 20:08:46 myvolumio volumio[13232]: at Socket.emit (events.js:315:20) Aug 23 20:08:46 myvolumio volumio[13232]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 23 20:08:46 myvolumio volumio[13232]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 23 20:08:46 myvolumio volumio[13232]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 20:08:46 myvolumio sudo[13418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 20:07 Aug 23 20:08:46 myvolumio sudo[13418]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"