-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Sun 2026-01-25 17:34:33 EST. --
Jan 25 17:33:00 volumio2 sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 25 17:33:00 volumio2 sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:00 volumio2 sudo[1293]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:00 volumio2 sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 25 17:33:00 volumio2 sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:00 volumio2 sudo[1295]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:00 volumio2 sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jan 25 17:33:00 volumio2 sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:00 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:00 volumio2 systemd[1]: Started UPnP Renderer front-end to MPD.
Jan 25 17:33:00 volumio2 sudo[1299]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:00 volumio2 volumio[1064]: info: Upmpdcli Daemon Started
Jan 25 17:33:00 volumio2 volumio[1301]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jan 25 17:33:00 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:01 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:01 volumio2 volumio[1301]: ...++++
Jan 25 17:33:01 volumio2 volumio[1064]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Jan 25 17:33:01 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:02 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:02 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:02 volumio2 sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //\\\\HPGAMER/Canvio/Music /mnt/NAS/HPGamerCanvio
Jan 25 17:33:02 volumio2 sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:02 volumio2 sudo[1318]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:02 volumio2 volumio[1064]: info: Cannot mount NAS HPGamerCanvio at system boot, trial number 3 ,retrying in 5 seconds
Jan 25 17:33:03 volumio2 systemd[1]: systemd-hostnamed.service: Succeeded.
Jan 25 17:33:03 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:03 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jan 25 17:33:04 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 25 17:33:04 volumio2 volumio[1064]: info: CURURI: music-library
Jan 25 17:33:04 volumio2 volumio[1064]: error: Failed LSINFO: null
Jan 25 17:33:04 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin bluetooth to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin multiroom to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin metavolumio to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin cd_controller to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin qobuzconnect to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin smart_inputs to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: Adding plugin tidalconnect to MyMusic Plugins
Jan 25 17:33:04 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jan 25 17:33:06 volumio2 volumio[1064]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jan 25 17:33:06 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jan 25 17:33:06 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 25 17:33:06 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 25 17:33:06 volumio2 volumio[1064]: info: Starting MyVolumio Remote Streaming Endpoints
Jan 25 17:33:06 volumio2 volumio[1064]: info: MyVolumio not started
Jan 25 17:33:06 volumio2 volumio[1064]: info: Initializing device activation check
Jan 25 17:33:06 volumio2 volumio[1064]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jan 25 17:33:06 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jan 25 17:33:07 volumio2 volumio[1064]: info: Starting Streaming Service Transparent Proxy
Jan 25 17:33:07 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jan 25 17:33:07 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jan 25 17:33:07 volumio2 volumio[1064]: info: Streaming services startup
Jan 25 17:33:07 volumio2 volumio[1064]: info: Starting Streaming Daemon
Jan 25 17:33:07 volumio2 sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jan 25 17:33:07 volumio2 sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:07 volumio2 sudo[1332]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:07 volumio2 volumio[1064]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jan 25 17:33:07 volumio2 volumio[1064]: error: Cannot start Volumio Streaming Daemon
Jan 25 17:33:07 volumio2 volumio[1064]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jan 25 17:33:07 volumio2 volumio[1064]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jan 25 17:33:07 volumio2 sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //\\\\HPGAMER/Canvio/Music /mnt/NAS/HPGamerCanvio
Jan 25 17:33:07 volumio2 sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:07 volumio2 volumio[1301]: ...............................................++++
Jan 25 17:33:07 volumio2 volumio[1301]: e is 65537 (0x010001)
Jan 25 17:33:07 volumio2 sudo[1340]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:07 volumio2 volumio[1064]: info: Cannot mount NAS HPGamerCanvio at system boot, trial number 4 ,retrying in 5 seconds
Jan 25 17:33:07 volumio2 volumio[1301]: writing RSA key
Jan 25 17:33:08 volumio2 volumio[1064]: STREAMING PROXY: Starting server on port 3245
Jan 25 17:33:08 volumio2 volumio[1064]: Node JS runtime: 14
Jan 25 17:33:12 volumio2 systemd[1]: systemd-timedated.service: Succeeded.
Jan 25 17:33:13 volumio2 sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.1 //\\\\HPGAMER/Canvio/Music /mnt/NAS/HPGamerCanvio
Jan 25 17:33:13 volumio2 sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 25 17:33:13 volumio2 sudo[1374]: pam_unix(sudo:session): session closed for user root
Jan 25 17:33:13 volumio2 volumio[1064]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Jan 25 17:33:14 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:14 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:18 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:18 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:21 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 25 17:33:21 volumio2 volumio[1064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 71
Jan 25 17:33:21 volumio2 volumio[1064]: info: CoreCommandRouter::volumioGetState
Jan 25 17:33:21 volumio2 volumio[1064]: info: CorePlayQueue::getTrack 0
Jan 25 17:33:21 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:23 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:24 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 25 17:33:24 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 25 17:33:24 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jan 25 17:33:24 volumio2 volumio-remote-updater[615]: No test mode
Jan 25 17:33:24 volumio2 volumio-remote-updater[615]: No alpha test mode
Jan 25 17:33:24 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jan 25 17:33:24 volumio2 volumio[1064]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Fix TIDAL low quality (AAC) playback
- Fix for DLNA Server discovery
- Fix for Plugins installation
NEW ADDITIONS
- BLE-based onboarding setup
- Update TIDAL SDK
","title":"Update v3.886","updateavailable":true}
Jan 25 17:33:24 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::volumioGetBrowseSources
Jan 25 17:33:26 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 25 17:33:27 volumio2 volumio[1064]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Jan 25 17:33:27 volumio2 volumio[1064]: info: Completed starting MyVolumio Plugin
Jan 25 17:33:27 volumio2 volumio[1064]: [Metrics] CommandRouter: 41s 144.01ms
Jan 25 17:33:27 volumio2 volumio[1064]: info: CoreCommandRouter::volumiosetStartupVolume
Jan 25 17:33:27 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 25 17:33:27 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 25 17:33:27 volumio2 volumio[1064]: info: CoreCommandRouter::Close All Modals sent
Jan 25 17:33:27 volumio2 volumio[1064]: info: CoreCommandRouter::Close All Modals sent
Jan 25 17:33:28 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jan 25 17:33:28 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 25 17:33:28 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jan 25 17:33:34 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:34 volumio2 volumio[1064]: info: BOOT COMPLETED
Jan 25 17:33:37 volumio2 ntpd[780]: Soliciting pool server 23.141.40.123
Jan 25 17:33:38 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:38 volumio2 ntpd[780]: Soliciting pool server 72.14.186.59
Jan 25 17:33:39 volumio2 ntpd[780]: Soliciting pool server 23.150.41.122
Jan 25 17:33:39 volumio2 ntpd[780]: Soliciting pool server 198.71.50.75
Jan 25 17:33:39 volumio2 ntpd[780]: Soliciting pool server 23.186.168.130
Jan 25 17:33:40 volumio2 ntpd[780]: Soliciting pool server 44.190.5.123
Jan 25 17:33:40 volumio2 ntpd[780]: Soliciting pool server 141.11.228.173
Jan 25 17:33:40 volumio2 ntpd[780]: Soliciting pool server 216.229.0.50
Jan 25 17:33:40 volumio2 ntpd[780]: Soliciting pool server 40.160.28.79
Jan 25 17:33:41 volumio2 ntpd[780]: Soliciting pool server 149.28.200.179
Jan 25 17:33:41 volumio2 ntpd[780]: Soliciting pool server 198.60.22.240
Jan 25 17:33:41 volumio2 ntpd[780]: Soliciting pool server 96.60.247.29
Jan 25 17:33:42 volumio2 ntpd[780]: Soliciting pool server 172.232.28.194
Jan 25 17:33:42 volumio2 ntpd[780]: Soliciting pool server 170.187.142.180
Jan 25 17:33:42 volumio2 ntpd[780]: Soliciting pool server 5.161.111.190
Jan 25 17:33:43 volumio2 ntpd[780]: Soliciting pool server 66.244.16.123
Jan 25 17:33:43 volumio2 ntpd[780]: Soliciting pool server 23.186.168.128
Jan 25 17:33:43 volumio2 ntpd[780]: Soliciting pool server 2606:82c0:21::e
Jan 25 17:33:43 volumio2 ntpd[780]: Soliciting pool server 198.137.202.56
Jan 25 17:33:43 volumio2 ntpd[780]: Soliciting pool server 99.28.14.242
Jan 25 17:33:44 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:45 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:46 volumio2 ntpd[780]: receive: Unexpected origin timestamp 0xed2118c9.ed7277ed does not match aorg 0000000000.00000000 from server@23.150.41.122 xmt 0xed2118ca.dcad9dac
Jan 25 17:33:46 volumio2 ntpd[780]: receive: Unexpected origin timestamp 0xed2118c9.ed7549ab does not match aorg 0000000000.00000000 from server@23.141.40.123 xmt 0xed2118ca.ddce717e
Jan 25 17:33:46 volumio2 ntpd[780]: receive: Unexpected origin timestamp 0xed2118c9.ed68919c does not match aorg 0000000000.00000000 from server@198.60.22.240 xmt 0xed2118ca.e1d41bd7
Jan 25 17:33:46 volumio2 ntpd[780]: receive: Unexpected origin timestamp 0xed2118c9.ed5ffd41 does not match aorg 0000000000.00000000 from server@66.244.16.123 xmt 0xed2118ca.e1da9b8d
Jan 25 17:33:46 volumio2 ntpd[780]: receive: Unexpected origin timestamp 0xed2118c9.ed6f785c does not match aorg 0000000000.00000000 from server@23.186.168.130 xmt 0xed2118ca.e1655c2e
Jan 25 17:33:48 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:49 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:52 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preload queue cleared
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49888
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49889
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49878
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49899
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49891
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49886
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49893
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49881
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49880
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49890
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49885
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49896
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49903
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49875
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49904
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49883
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49898
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49901
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49884
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49882
Jan 25 17:33:52 volumio2 volumio[1064]: info: Preloading song: upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49876
Jan 25 17:33:52 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49888 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: No valid Plugin REST Endpoint
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49889 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49878 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49899 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49891 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49886 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49893 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49881 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49880 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49890 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49885 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49896 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49903 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49875 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49904 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49883 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49898 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49901 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49884 in service upnp_browser
Jan 25 17:33:53 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49882 in service upnp_browser
Jan 25 17:33:54 volumio2 volumio[1064]: info: Exploding uri upnp/http://10.0.0.78:2869/upnphost/udhisapi.dll?control=uuid:88aafbae-8e06-4121-96e2-00df795032de+urn:upnp-org:serviceId:ContentDirectory@6_dff36b1_557a2eb5-49876 in service upnp_browser
Jan 25 17:34:22 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:34:23 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:34:23 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:34:32 volumio2 volumio[1064]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jan 25 17:34:32 volumio2 volumio[1064]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 25 17:34:32 volumio2 volumio[1064]: TypeError: Cannot read property 'length' of undefined
Jan 25 17:34:32 volumio2 volumio[1064]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Jan 25 17:34:32 volumio2 volumio[1064]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Jan 25 17:34:32 volumio2 volumio[1064]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Jan 25 17:34:32 volumio2 volumio[1064]: at Parser.emit (events.js:315:20)
Jan 25 17:34:32 volumio2 volumio[1064]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Jan 25 17:34:32 volumio2 volumio[1064]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Jan 25 17:34:32 volumio2 volumio[1064]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Jan 25 17:34:32 volumio2 volumio[1064]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Jan 25 17:34:32 volumio2 volumio[1064]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Jan 25 17:34:32 volumio2 volumio[1064]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Jan 25 17:34:32 volumio2 volumio[1064]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Jan 25 17:34:32 volumio2 volumio[1064]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Jan 25 17:34:32 volumio2 volumio[1064]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Jan 25 17:34:32 volumio2 volumio[1064]: at IncomingMessage.emit (events.js:327:22)
Jan 25 17:34:32 volumio2 volumio[1064]: at endReadableNT (internal/streams/readable.js:1327:12)
Jan 25 17:34:32 volumio2 volumio[1064]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Jan 25 17:34:32 volumio2 volumio[1064]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 25 17:34:33 volumio2 sudo[1592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-25 17:33
Jan 25 17:34:33 volumio2 sudo[1592]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"