-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Tue 2024-07-16 07:40:14 CDT. -- Jul 16 07:39:19 orchard systemd[1]: Starting Daily apt upgrade and clean activities... Jul 16 07:39:19 orchard systemd[1]: Starting Daily man-db regeneration... Jul 16 07:39:19 orchard ntpd[689]: receive: Unexpected origin timestamp 0xea405c07.3014e151 does not match aorg 0000000000.00000000 from server@45.83.234.123 xmt 0xea40e876.e72ffc3c Jul 16 07:39:19 orchard ntpd[689]: Soliciting pool server 73.193.62.54 Jul 16 07:39:19 orchard systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 16 07:39:19 orchard systemd[1]: Started Daily apt upgrade and clean activities. Jul 16 07:39:20 orchard systemd[1]: man-db.service: Succeeded. Jul 16 07:39:20 orchard systemd[1]: Started Daily man-db regeneration. Jul 16 07:39:27 orchard volumio-remote-updater[517]: [2024-07-16 07:39:27] [connect] Successful connection Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.522678, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jul 16 07:39:27 orchard nmbd[665]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523089, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jul 16 07:39:27 orchard nmbd[665]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523217, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jul 16 07:39:27 orchard nmbd[665]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523334, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jul 16 07:39:27 orchard nmbd[665]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523447, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jul 16 07:39:27 orchard nmbd[665]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523534, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jul 16 07:39:27 orchard nmbd[665]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523627, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jul 16 07:39:27 orchard nmbd[665]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523736, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jul 16 07:39:27 orchard nmbd[665]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523817, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jul 16 07:39:27 orchard nmbd[665]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523896, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jul 16 07:39:27 orchard nmbd[665]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jul 16 07:39:27 orchard nmbd[665]: [2024/07/16 07:39:27.523972, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jul 16 07:39:27 orchard nmbd[665]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jul 16 07:39:42 orchard volumio-remote-updater[517]: [2024-07-16 07:39:42] [connect] Successful connection Jul 16 07:39:47 orchard volumio-remote-updater[517]: [2024-07-16 07:39:47] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jul 16 07:39:47 orchard volumio-remote-updater[517]: [2024-07-16 07:39:47] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jul 16 07:39:47 orchard volumio-remote-updater[517]: [2024-07-16 07:39:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jul 16 07:39:47 orchard systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jul 16 07:39:47 orchard systemd[1]: volumio.service: Failed with result 'exit-code'. Jul 16 07:39:47 orchard systemd[1]: Started dynamicswap service. Jul 16 07:39:47 orchard systemd[1]: dynamicswap.service: Succeeded. Jul 16 07:39:47 orchard systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 16 07:39:47 orchard systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jul 16 07:39:47 orchard systemd[1]: Stopped Volumio Backend Module. Jul 16 07:39:47 orchard systemd[1]: Started Volumio Backend Module. Jul 16 07:39:47 orchard systemd[1]: Started dynamicswap service. Jul 16 07:39:47 orchard systemd[1]: dynamicswap.service: Succeeded. Jul 16 07:39:50 orchard volumio[1562]: info: ------------------------------------------- Jul 16 07:39:50 orchard volumio[1562]: info: ----- Volumio3 ---- Jul 16 07:39:50 orchard volumio[1562]: info: ------------------------------------------- Jul 16 07:39:50 orchard volumio[1562]: info: ----- System startup ---- Jul 16 07:39:50 orchard volumio[1562]: info: ------------------------------------------- Jul 16 07:39:51 orchard volumio[1562]: info: MYVOLUMIO Environment detected Jul 16 07:39:51 orchard volumio[1562]: info: Plugin folders cleanup Jul 16 07:39:51 orchard volumio[1562]: info: Scanning into folder /volumio/app/plugins/ Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category audio_interface Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category miscellanea Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category music_service Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category plugins.json Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category system_controller Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category user_interface Jul 16 07:39:51 orchard volumio[1562]: info: Scanning into folder /data/plugins/ Jul 16 07:39:51 orchard volumio[1562]: info: Scanning category audio_interface Jul 16 07:39:51 orchard volumio[1562]: info: Plugin folders cleanup completed Jul 16 07:39:51 orchard volumio[1562]: info: ------------------------------------------- Jul 16 07:39:51 orchard volumio[1562]: info: ----- Core plugins startup ---- Jul 16 07:39:51 orchard volumio[1562]: info: ------------------------------------------- Jul 16 07:39:51 orchard volumio[1562]: info: Loading plugins from folder /volumio/app/plugins/ Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin multiroom to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin upnp to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin metavolumio to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin cd_controller to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin raat to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 16 07:39:51 orchard volumio[1562]: info: Loading plugins from folder /data/plugins/ Jul 16 07:39:51 orchard volumio[1562]: info: Loading plugin "system"... Jul 16 07:39:51 orchard volumio[1562]: info: Loading plugin "appearance"... Jul 16 07:39:52 orchard volumio[1562]: info: Loading plugin "network"... Jul 16 07:39:52 orchard volumio[1562]: info: Refreshing Cached IP Addresses Jul 16 07:39:52 orchard sudo[1599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 16 07:39:52 orchard sudo[1599]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:39:52 orchard sudo[1601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 16 07:39:52 orchard volumio[1562]: info: Loading plugin "services"... Jul 16 07:39:52 orchard sudo[1601]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:39:52 orchard sudo[1599]: pam_unix(sudo:session): session closed for user root Jul 16 07:39:52 orchard volumio[1562]: info: Loading plugin "alsa_controller"... Jul 16 07:39:52 orchard sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 16 07:39:52 orchard sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:39:53 orchard sudo[1605]: pam_unix(sudo:session): session closed for user root Jul 16 07:39:53 orchard sudo[1601]: pam_unix(sudo:session): session closed for user root Jul 16 07:39:53 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "wizard"... Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "networkfs"... Jul 16 07:39:53 orchard volumio[1562]: info: Starting Udev Watcher for removable devices Jul 16 07:39:53 orchard volumio[1562]: info: Ignoring mount for partition: boot Jul 16 07:39:53 orchard volumio[1562]: info: Ignoring mount for partition: volumio Jul 16 07:39:53 orchard volumio[1562]: info: Ignoring mount for partition: volumio_data Jul 16 07:39:53 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "volumio_command_line_client"... Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "upnp"... Jul 16 07:39:53 orchard volumio[1562]: info: [1721133593214] Starting Upmpd Daemon Jul 16 07:39:53 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "my_music"... Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "mpd"... Jul 16 07:39:53 orchard volumio[1562]: info: Loading plugin "upnp_browser"... Jul 16 07:39:54 orchard volumio[1562]: info: Loading plugin "alarm-clock"... Jul 16 07:39:54 orchard volumio[1562]: info: Loading plugin "manifestui"... Jul 16 07:39:54 orchard volumio[1562]: info: Loading plugin "metavolumio"... Jul 16 07:39:56 orchard volumio[1562]: info: Loading plugin "airplay_emulation"... Jul 16 07:39:56 orchard volumio[1562]: info: Starting Shairport Sync Jul 16 07:39:56 orchard volumio[1562]: info: Loading plugin "cd_controller"... Jul 16 07:39:56 orchard volumio[1562]: info: Loading plugin "last_100"... Jul 16 07:39:56 orchard volumio[1562]: info: Loading plugin "raat"... Jul 16 07:39:57 orchard volumio-remote-updater[517]: [2024-07-16 07:39:57] [connect] Successful connection Jul 16 07:39:57 orchard volumio[1562]: info: RAAT Plugin loaded Jul 16 07:39:57 orchard volumio[1562]: info: Adding restartRAATSocket REST API Endpoint Jul 16 07:39:57 orchard volumio[1562]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Jul 16 07:39:57 orchard volumio[1562]: info: Loading plugin "streaming_services"... Jul 16 07:39:58 orchard volumio[1562]: info: Starting Streaming Service Transparent Proxy Jul 16 07:39:58 orchard volumio[1562]: info: Loading plugin "tidalconnect"... Jul 16 07:39:59 orchard volumio[1562]: info: Loading plugin "webradio"... Jul 16 07:39:59 orchard volumio[1562]: info: Loading plugin "i2s_dacs"... Jul 16 07:39:59 orchard volumio[1562]: info: I2S DAC not set, start Auto-detection Jul 16 07:39:59 orchard volumio[1562]: info: Loading plugin "volumiodiscovery"... Jul 16 07:39:59 orchard volumio[1562]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 16 07:39:59 orchard volumio[1562]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 07:39:59 orchard volumio[1562]: *** WARNING *** For more information see Jul 16 07:39:59 orchard node[1562]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 16 07:39:59 orchard volumio[1562]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 16 07:39:59 orchard volumio[1562]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 07:39:59 orchard volumio[1562]: *** WARNING *** For more information see Jul 16 07:39:59 orchard node[1562]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 07:39:59 orchard node[1562]: *** WARNING *** For more information see Jul 16 07:39:59 orchard node[1562]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 16 07:39:59 orchard node[1562]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 16 07:39:59 orchard node[1562]: *** WARNING *** For more information see Jul 16 07:39:59 orchard volumio[1562]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 16 07:39:59 orchard volumio[1562]: info: Discovery: Started advertising with name: orchard Jul 16 07:39:59 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 16 07:39:59 orchard volumio[1562]: info: Loading plugin "multiroom"... Jul 16 07:40:00 orchard volumio[1562]: STREAMING PROXY: Starting server on port 3245 Jul 16 07:40:00 orchard volumio[1562]: Node JS runtime: 14 Jul 16 07:40:01 orchard volumio[1562]: info: Applying required configuration parameters for plugin multiroom Jul 16 07:40:01 orchard sudo[1664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jul 16 07:40:01 orchard sudo[1664]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:01 orchard sudo[1664]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:01 orchard volumio[1562]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Jul 16 07:40:01 orchard volumio[1562]: info: MRS: MultiRoom plugin initialized Jul 16 07:40:01 orchard volumio[1562]: info: MRS: STOPPING SNAPCLIENT Jul 16 07:40:01 orchard volumio[1562]: info: MRS: Snap server stop Jul 16 07:40:01 orchard sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jul 16 07:40:01 orchard sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:01 orchard volumio[1562]: info: MRS: STOPPING volumioStreaming Jul 16 07:40:01 orchard sudo[1682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jul 16 07:40:01 orchard sudo[1682]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:01 orchard sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 16 07:40:01 orchard sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:01 orchard volumio[1562]: info: Loading plugin "outputs"... Jul 16 07:40:01 orchard volumio[1562]: info: Loading plugin "albumart"... Jul 16 07:40:01 orchard sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 16 07:40:01 orchard sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:01 orchard sudo[1682]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:01 orchard sudo[1688]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:01 orchard sudo[1680]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:01 orchard volumio[1562]: info: Plugin example_plugin is not enabled Jul 16 07:40:01 orchard volumio[1562]: info: Loading plugin "hi_res_audio"... Jul 16 07:40:01 orchard sudo[1686]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:02 orchard volumio[1562]: Forking 3 albumart workers Jul 16 07:40:03 orchard volumio[1562]: Starting albumart workers Jul 16 07:40:03 orchard volumio[1562]: Starting albumart workers Jul 16 07:40:03 orchard volumio[1562]: Starting albumart workers Jul 16 07:40:03 orchard volumio[1562]: info: Applying required configuration parameters for plugin hi_res_audio Jul 16 07:40:03 orchard volumio[1562]: info: Loading plugin "inputs"... Jul 16 07:40:03 orchard volumio[1562]: info: Loading plugin "qobuz"... Jul 16 07:40:05 orchard volumio[1562]: info: Loading plugin "smart_inputs"... Jul 16 07:40:05 orchard volumio[1562]: info: Loading plugin "tidal"... Jul 16 07:40:06 orchard volumio[1562]: info: Loading plugin "acontrol"... Jul 16 07:40:06 orchard volumio[1562]: info: Adding this device properties Jul 16 07:40:06 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jul 16 07:40:06 orchard volumio[1562]: info: Setting Additional Device Volumio Properties: [object Object] Jul 16 07:40:06 orchard volumio[1562]: info: Loading plugin "oem_helper"... Jul 16 07:40:08 orchard volumio[1562]: info: Applying required configuration parameters for plugin oem_helper Jul 16 07:40:08 orchard volumio[1562]: info: Loading plugin "updater_comm"... Jul 16 07:40:08 orchard volumio[1562]: info: Plugin mpdemulation is not enabled Jul 16 07:40:08 orchard volumio[1562]: info: Loading plugin "rest_api"... Jul 16 07:40:08 orchard volumio[1562]: info: Loading plugin "websocket"... Jul 16 07:40:08 orchard volumio[1562]: info: Loading plugin "fusiondsp"... Jul 16 07:40:08 orchard volumio[1562]: info: Applying required configuration parameters for plugin fusiondsp Jul 16 07:40:08 orchard volumio[1562]: info: Loading i18n strings for locale en Jul 16 07:40:08 orchard volumio[1562]: Updating browse sources language Jul 16 07:40:08 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::initPlayerControls Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: Express server listening on port 3000 Jul 16 07:40:09 orchard volumio[1562]: [Metrics] WebUI: 19s 974.31ms Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::resetVolumioState Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::getcurrentVolume Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::volumioRetrievevolume Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::pushState Jul 16 07:40:09 orchard volumio[1562]: info: CorePlayQueue::getTrack 0 Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::volumioPushState Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::updateTrackBlock Jul 16 07:40:09 orchard sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 16 07:40:09 orchard sudo[1757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 16 07:40:09 orchard sudo[1757]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:09 orchard sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:09 orchard volumio[1562]: info: CorePlayQueue::getTrackBlock Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::volumioRetrievevolume Jul 16 07:40:09 orchard sudo[1755]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:09 orchard sudo[1757]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:09 orchard volumio[1562]: info: MRS: Removed streaming files Jul 16 07:40:09 orchard volumio[1562]: info: MRS: volumioStreaming STOPPED Jul 16 07:40:09 orchard volumio[1562]: info: MRS: SNAPSERVER STOPPED Jul 16 07:40:09 orchard volumio[1562]: info: MRS: SNAPCLIENT STOPPED Jul 16 07:40:09 orchard volumio[1562]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 16 07:40:09 orchard volumio[1562]: wlan0 Interface doesn't support scanning. Jul 16 07:40:09 orchard volumio[1562]: info: Cannot use regular scanning, forcing with ap-force Jul 16 07:40:09 orchard sudo[1769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 16 07:40:09 orchard sudo[1769]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:09 orchard sudo[1769]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:09 orchard volumio[1562]: command failed: No such device (-19) Jul 16 07:40:09 orchard volumio[1562]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 16 07:40:09 orchard volumio[1562]: command failed: No such device (-19) Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::pushState Jul 16 07:40:09 orchard volumio[1562]: info: CorePlayQueue::getTrack 0 Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::volumioPushState Jul 16 07:40:09 orchard volumio[1562]: info: Reloading queue from file Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::setRepeat null single undefined Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::pushState Jul 16 07:40:09 orchard volumio[1562]: info: CorePlayQueue::getTrack 0 Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::volumioPushState Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::setRandom null Jul 16 07:40:09 orchard volumio[1562]: info: CoreStateMachine::pushState Jul 16 07:40:09 orchard volumio[1562]: info: CorePlayQueue::getTrack 0 Jul 16 07:40:09 orchard volumio[1562]: info: CoreCommandRouter::volumioPushState Jul 16 07:40:09 orchard volumio[1562]: info: Setting Device type: Raspberry PI Jul 16 07:40:09 orchard volumio[1562]: info: Completed loading Core Plugins Jul 16 07:40:09 orchard volumio[1562]: info: Preparing to generate the ALSA configuration file Jul 16 07:40:09 orchard sudo[1779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 16 07:40:09 orchard sudo[1779]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:09 orchard volumio[1562]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 16 07:40:09 orchard volumio[1562]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 16 07:40:09 orchard volumio[1562]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 16 07:40:09 orchard volumio[1562]: info: Reading ALSA contributions from plugins. Jul 16 07:40:09 orchard volumio[1562]: info: Asound.conf file unchanged, so no further update is needed Jul 16 07:40:09 orchard volumio[1562]: info: Output device has changed, restarting MPD Jul 16 07:40:09 orchard sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 16 07:40:09 orchard sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:09 orchard sudo[1782]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:09 orchard sudo[1779]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:10 orchard volumio[1562]: info: Output device has changed, restarting Shairport Sync Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:10 orchard sudo[1785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 16 07:40:10 orchard sudo[1785]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:10 orchard systemd[1]: Stopping Music Player Daemon... Jul 16 07:40:10 orchard volumio[1562]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 07:40:10 orchard volumio[1562]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: ___________ START PLUGINS ___________ Jul 16 07:40:10 orchard volumio[1562]: info: ControllerMpd::onStart: Initializing MPD Jul 16 07:40:10 orchard volumio[1562]: info: Creating MPD Configuration file Jul 16 07:40:10 orchard sudo[1793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 16 07:40:10 orchard sudo[1793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:10 orchard sudo[1793]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 07:40:10 orchard volumio[1562]: info: [1721133610182] CoreMusicLibrary::Adding element Media Servers Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 07:40:10 orchard sudo[1796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 16 07:40:10 orchard sudo[1796]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:10 orchard volumio[1562]: info: Adding Manifest REST API Endpoints Jul 16 07:40:10 orchard volumio[1562]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Jul 16 07:40:10 orchard volumio[1562]: info: Adding METAVOLUMIO REST API Endpoints Jul 16 07:40:10 orchard volumio[1562]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jul 16 07:40:10 orchard volumio[1562]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jul 16 07:40:10 orchard volumio[1562]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jul 16 07:40:10 orchard volumio[1562]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 07:40:10 orchard volumio[1562]: info: Preparing CD Folders Jul 16 07:40:10 orchard volumio[1562]: info: Adding CD REST API Endpoints Jul 16 07:40:10 orchard volumio[1562]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jul 16 07:40:10 orchard volumio[1562]: info: Starting UDEV Watcher for CD Jul 16 07:40:10 orchard volumio[1562]: info: Detecting CD presence with UDEV Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 07:40:10 orchard volumio[1562]: info: [1721133610353] CoreMusicLibrary::Adding element Last_100 Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 07:40:10 orchard volumio[1562]: info: Starting RAAT Plugin Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jul 16 07:40:10 orchard volumio[1562]: info: Additional UI Settings Added for plugin music_service/raat Jul 16 07:40:10 orchard volumio[1562]: info: Registering DSP Elements listener and retrieving current ones Jul 16 07:40:10 orchard volumio[1562]: info: Additional DSP elements updated Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: Updating RAAT Signal Path Jul 16 07:40:10 orchard volumio[1562]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: Streaming services startup Jul 16 07:40:10 orchard volumio[1562]: info: Starting Streaming Daemon Jul 16 07:40:10 orchard sudo[1809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 16 07:40:10 orchard sudo[1809]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:10 orchard sudo[1809]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 16 07:40:10 orchard volumio[1562]: info: [1721133610573] CoreMusicLibrary::Adding element Webradio Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 07:40:10 orchard volumio[1562]: info: Initializing BBC Radios Jul 16 07:40:10 orchard sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 16 07:40:10 orchard sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:10 orchard sudo[1816]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:10 orchard systemd[1]: mpd.service: Succeeded. Jul 16 07:40:10 orchard systemd[1]: Stopped Music Player Daemon. Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jul 16 07:40:10 orchard volumio[1562]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:10 orchard systemd[1]: Starting Music Player Daemon... Jul 16 07:40:10 orchard volumio[1562]: error: Hi Res Audio Failed Login: Missing Login Data Jul 16 07:40:10 orchard volumio[1562]: info: Adding HIGHRESAUDIO REST API Endpoints Jul 16 07:40:10 orchard volumio[1562]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jul 16 07:40:10 orchard volumio[1562]: info: Refreshing QOBUZ token Jul 16 07:40:10 orchard volumio[1562]: info: Adding inputs REST Endpoints Jul 16 07:40:10 orchard volumio[1562]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jul 16 07:40:10 orchard volumio[1562]: info: Scanning Audio Inputs Jul 16 07:40:10 orchard volumio[1562]: info: Checking against Known Cards name Jul 16 07:40:10 orchard volumio[1562]: info: Checking against Known Cards name Jul 16 07:40:10 orchard volumio[1562]: info: Adding Server instance for streaming Jul 16 07:40:10 orchard volumio[1562]: info: Refreshing TIDAL token Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 16 07:40:10 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:10 orchard volumio[1562]: info: Loading i18n strings for locale en Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: FusionDsp - mixtype--------------------- Software Jul 16 07:40:11 orchard volumio[1562]: info: Volumio Calling Home Jul 16 07:40:11 orchard volumio[1562]: (node:1562) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jul 16 07:40:11 orchard volumio[1562]: (Use `node --trace-deprecation ...` to show where the warning was created) Jul 16 07:40:11 orchard volumio[1562]: info: Preparing to generate the ALSA configuration file Jul 16 07:40:11 orchard volumio[1562]: info: Discovery: adding 1a4db29c-174a-462c-a36f-448bb50ac2cf Jul 16 07:40:11 orchard volumio[1562]: info: Discovery: Found device orchard Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::volumioGetState Jul 16 07:40:11 orchard volumio[1562]: info: CorePlayQueue::getTrack 0 Jul 16 07:40:11 orchard volumio[1562]: info: MRS: Pushing multiroomSync output for this device Jul 16 07:40:11 orchard volumio[1562]: info: MRS: Pushing multiroomSync output Jul 16 07:40:11 orchard volumio[1562]: info: Adding audio output: Jul 16 07:40:11 orchard volumio[1562]: info: Adding audio output: Jul 16 07:40:11 orchard volumio[1562]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 16 07:40:11 orchard volumio[1562]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 16 07:40:11 orchard volumio[1562]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 16 07:40:11 orchard volumio[1562]: info: Reading ALSA contributions from plugins. Jul 16 07:40:11 orchard volumio[1562]: error: Cannot start Volumio Streaming Daemon Jul 16 07:40:11 orchard volumio[1562]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 16 07:40:11 orchard volumio[1562]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 16 07:40:11 orchard volumio[1562]: info: MPD Permissions set Jul 16 07:40:11 orchard volumio[1562]: info: MPD Permissions set Jul 16 07:40:11 orchard volumio[1562]: info: Upmpdcli Daemon Started Jul 16 07:40:11 orchard volumio[1562]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 16 07:40:11 orchard sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jul 16 07:40:11 orchard sudo[1860]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:11 orchard sudo[1860]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:11 orchard sudo[1862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 16 07:40:11 orchard sudo[1862]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:11 orchard volumio[1562]: info: Starting Shairport Sync Jul 16 07:40:11 orchard systemd[1]: Stopping RAAT DAEMON... Jul 16 07:40:11 orchard systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jul 16 07:40:11 orchard systemd[1]: raat-daemon.service: Succeeded. Jul 16 07:40:11 orchard systemd[1]: Stopped RAAT DAEMON. Jul 16 07:40:11 orchard volumio[1562]: info: Starting Shairport Sync Jul 16 07:40:11 orchard sudo[1866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 07:40:11 orchard sudo[1866]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:11 orchard systemd[1]: Started RAAT DAEMON. Jul 16 07:40:11 orchard volumio[1562]: info: Starting Shairport Sync Jul 16 07:40:11 orchard sudo[1868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 07:40:11 orchard sudo[1868]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:11 orchard sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 07:40:11 orchard sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:11 orchard sudo[1862]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:11 orchard systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 16 07:40:11 orchard volumio[1562]: info: Asound.conf file unchanged, so no further update is needed Jul 16 07:40:11 orchard volumio[1562]: info: Output device has changed, restarting MPD Jul 16 07:40:11 orchard systemd[1]: shairport-sync.service: Succeeded. Jul 16 07:40:11 orchard systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 16 07:40:11 orchard systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 16 07:40:11 orchard sudo[1875]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:11 orchard sudo[1868]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:11 orchard sudo[1866]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:11 orchard volumio[1562]: info: Output device has changed, restarting Shairport Sync Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:11 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:11 orchard sudo[1880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 16 07:40:11 orchard sudo[1880]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:11 orchard sudo[1880]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:12 orchard sudo[1882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 16 07:40:12 orchard sudo[1882]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:12 orchard volumio-remote-updater[517]: [2024-07-16 07:40:12] [connect] Successful connection Jul 16 07:40:12 orchard volumio[1562]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 07:40:12 orchard volumio[1562]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 16 07:40:12 orchard systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 16 07:40:12 orchard systemd[1]: mpd.service: Succeeded. Jul 16 07:40:12 orchard systemd[1]: Stopped Music Player Daemon. Jul 16 07:40:12 orchard volumio[1562]: info: Raat Daemon started successfully Jul 16 07:40:12 orchard systemd[1]: Starting Music Player Daemon... Jul 16 07:40:12 orchard volumio[1562]: info: MPD Permissions set Jul 16 07:40:12 orchard volumio[1562]: info: Shairport-Sync Started Jul 16 07:40:12 orchard volumio[1562]: Error adding Membership: Error: addMembership EINVAL Jul 16 07:40:12 orchard volumio[1562]: info: Shairport-Sync Started Jul 16 07:40:12 orchard volumio[1562]: info: Shairport-Sync Started Jul 16 07:40:12 orchard volumio[1562]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jul 16 07:40:12 orchard volumio[1562]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio-remote-updater[517]: [2024-07-16 07:40:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1721133612 101 Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: Starting Shairport Sync Jul 16 07:40:12 orchard volumio[1562]: info: Preparing to generate the ALSA configuration file Jul 16 07:40:12 orchard sudo[1898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 16 07:40:12 orchard sudo[1898]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:12 orchard volumio[1562]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 16 07:40:12 orchard volumio[1562]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 16 07:40:12 orchard volumio[1562]: info: MRS: Found cast device: V505-G9-9d2bd7e285d0f08d909be62c52283507 Jul 16 07:40:12 orchard volumio[1562]: info: Adding audio output: Jul 16 07:40:12 orchard systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 16 07:40:12 orchard systemd[1]: shairport-sync.service: Succeeded. Jul 16 07:40:12 orchard volumio[1562]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 16 07:40:12 orchard systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 16 07:40:12 orchard volumio[1562]: info: Reading ALSA contributions from plugins. Jul 16 07:40:12 orchard volumio[1562]: info: Volumio called home Jul 16 07:40:12 orchard systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 16 07:40:12 orchard sudo[1898]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::volumioGetState Jul 16 07:40:12 orchard volumio[1562]: info: CorePlayQueue::getTrack 0 Jul 16 07:40:12 orchard volumio[1562]: info: Shairport-Sync Started Jul 16 07:40:12 orchard volumio[1562]: info: Asound.conf file unchanged, so no further update is needed Jul 16 07:40:12 orchard volumio[1562]: info: Output device has changed, restarting MPD Jul 16 07:40:12 orchard volumio[1562]: info: Output device has changed, restarting Shairport Sync Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:12 orchard sudo[1906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 16 07:40:12 orchard sudo[1906]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:12 orchard systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 16 07:40:12 orchard systemd[1]: mpd.service: Succeeded. Jul 16 07:40:12 orchard systemd[1]: Stopped Music Player Daemon. Jul 16 07:40:12 orchard systemd[1]: Starting Music Player Daemon... Jul 16 07:40:12 orchard volumio[1562]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 16 07:40:12 orchard volumio[1562]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 16 07:40:12 orchard sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:12 orchard volumio[1562]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 16 07:40:12 orchard sudo[1904]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jul 16 07:40:12 orchard volumio[1562]: info: MPD Permissions set Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:12 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 16 07:40:12 orchard sudo[1926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jul 16 07:40:12 orchard sudo[1926]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:12 orchard sudo[1926]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:12 orchard sudo[1928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 16 07:40:12 orchard sudo[1928]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:12 orchard systemd[1]: Stopping RAAT DAEMON... Jul 16 07:40:12 orchard systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jul 16 07:40:12 orchard systemd[1]: raat-daemon.service: Succeeded. Jul 16 07:40:12 orchard systemd[1]: Stopped RAAT DAEMON. Jul 16 07:40:12 orchard systemd[1]: Started RAAT DAEMON. Jul 16 07:40:12 orchard sudo[1928]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:13 orchard volumio[1562]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 16 07:40:13 orchard volumio[1562]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jul 16 07:40:13 orchard volumio[1562]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 16 07:40:13 orchard volumio[1562]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jul 16 07:40:13 orchard volumio[1562]: info: camilladsp service started and running in background, instance 1 Jul 16 07:40:13 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:13 orchard volumio[1562]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 16 07:40:13 orchard volumio[1562]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 16 07:40:13 orchard volumio[1562]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 16 07:40:13 orchard volumio[1562]: info: FusionDsp loaded Jul 16 07:40:13 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 16 07:40:13 orchard sudo[1945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 16 07:40:13 orchard sudo[1945]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 16 07:40:13 orchard sudo[1945]: pam_unix(sudo:session): session closed for user root Jul 16 07:40:13 orchard volumio[1562]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 16 07:40:13 orchard volumio[1562]: info: Adding Signal Path Element [object Object] Jul 16 07:40:13 orchard volumio[1562]: info: Adding fusiondspeq DSP Signal Path Element Jul 16 07:40:13 orchard volumio[1562]: info: Additional DSP elements updated Jul 16 07:40:13 orchard volumio[1562]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 16 07:40:13 orchard volumio[1562]: info: Updating RAAT Signal Path Jul 16 07:40:13 orchard volumio[1562]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 16 07:40:13 orchard volumio[1562]: info: FusionDsp - ---- installed callbackRead Jul 16 07:40:13 orchard volumio[1562]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 07:40:13 orchard volumio[1562]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 16 07:40:13 orchard volumio[1562]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jul 16 07:40:13 orchard volumio[1562]: at onErrorNT (internal/child_process.js:465:16) Jul 16 07:40:13 orchard volumio[1562]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 16 07:40:13 orchard volumio[1562]: at runNextTicks (internal/process/task_queues.js:62:3) Jul 16 07:40:13 orchard volumio[1562]: at listOnTimeout (internal/timers.js:523:9) Jul 16 07:40:13 orchard volumio[1562]: at processTimers (internal/timers.js:497:7) { Jul 16 07:40:13 orchard volumio[1562]: errno: -2, Jul 16 07:40:13 orchard volumio[1562]: code: 'ENOENT', Jul 16 07:40:13 orchard volumio[1562]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 16 07:40:13 orchard volumio[1562]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 16 07:40:13 orchard volumio[1562]: spawnargs: [ Jul 16 07:40:13 orchard volumio[1562]: '-p', Jul 16 07:40:13 orchard volumio[1562]: 9876, Jul 16 07:40:13 orchard volumio[1562]: '-o', Jul 16 07:40:13 orchard volumio[1562]: '/tmp/camilladsp.log', Jul 16 07:40:13 orchard volumio[1562]: '-l', Jul 16 07:40:13 orchard volumio[1562]: 'warn', Jul 16 07:40:13 orchard volumio[1562]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 16 07:40:13 orchard volumio[1562]: ] Jul 16 07:40:13 orchard volumio[1562]: } Jul 16 07:40:13 orchard volumio[1562]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 07:40:14 orchard kernel: sched: RT throttling activated Jul 16 07:40:14 orchard sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-16 07:39 Jul 16 07:40:14 orchard sudo[1956]: 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="729fabca6039b61f31dfca69e97e8cbc8803e4d0" VOLUMIO_FE_VERSION="4046dddc0717a69457a40270e2fcbc46f9ee4c24" VOLUMIO_FE3_VERSION="19db4344fa87f8eaaab1560f7319710ca849c94e" VOLUMIO_BE_VERSION="9010a4e812306a439f27f77137bdcca269a30a20" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="orchard" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 05 May 2024 10:22:41 PM CEST" VOLUMIO_VERSION="3.667" VOLUMIO_HARDWARE="pi-kiosk" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_VENDOR_MODEL="Orchard Audio PecanPi+ Streamer Premium" VOLUMIO_VENDOR="Orchard Audio" VOLUMIO_MODEL="PecanPi+ Streamer Premium" VOLUMIO_HASH="7cde398471f902a1506eb2e779a2c221"