-- Logs begin at Thu 2019-02-14 02:11:59 PST, end at Sun 2024-10-06 16:28:55 PDT. -- Oct 06 16:27:02 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:06 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:10 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:14 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:18 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:22 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:26 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:26 hifiguy go-librespot[1829]: time="2024-10-06T16:27:26-07:00" level=trace msg="emitting websocket event: not_playing" Oct 06 16:27:26 hifiguy go-librespot[1829]: time="2024-10-06T16:27:26-07:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:27:26 hifiguy volumio[990]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:21Y7Om8LTUS5dNKqKYeywc","play_origin":"playlist/ondemand"}} Oct 06 16:27:26 hifiguy volumio[990]: error: Failed to decode event: not_playing Oct 06 16:27:26 hifiguy volumio[990]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:21Y7Om8LTUS5dNKqKYeywc","play_origin":"playlist/ondemand"}} Oct 06 16:27:26 hifiguy volumio[990]: error: Failed to decode event: not_playing Oct 06 16:27:26 hifiguy go-librespot[1829]: time="2024-10-06T16:27:26-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 06 16:27:26 hifiguy go-librespot[1829]: time="2024-10-06T16:27:26-07:00" level=trace msg="emitting websocket event: will_play" Oct 06 16:27:26 hifiguy volumio[990]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","play_origin":"playlist/ondemand"}} Oct 06 16:27:26 hifiguy go-librespot[1829]: time="2024-10-06T16:27:26-07:00" level=info msg="loaded track \"多謝你自己\" (paused: false, position: 0ms, duration: 259635ms, prefetched: true)" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:27:26 hifiguy go-librespot[1829]: time="2024-10-06T16:27:26-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 06 16:27:27 hifiguy go-librespot[1829]: time="2024-10-06T16:27:27-07:00" level=trace msg="scheduling prefetch in 229s" Oct 06 16:27:27 hifiguy go-librespot[1829]: time="2024-10-06T16:27:27-07:00" level=trace msg="emitting websocket event: metadata" Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","name":"多謝你自己","artist_names":["Dear Jane"],"album_name":"多謝你自己","album_cover_url":"https://i.scdn.co/image/ab67616d00001e020b0a54bc1303a2b0887d15cd","position":0,"duration":259635,"release_date":"year:2024 month:7 day:2","track_number":1,"disc_number":1}} Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","name":"多謝你自己","artist_names":["Dear Jane"],"album_name":"多謝你自己","album_cover_url":"https://i.scdn.co/image/ab67616d00001e020b0a54bc1303a2b0887d15cd","position":0,"duration":259635,"release_date":"year:2024 month:7 day:2","track_number":1,"disc_number":1}} Oct 06 16:27:27 hifiguy go-librespot[1829]: time="2024-10-06T16:27:27-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 06 16:27:27 hifiguy go-librespot[1829]: time="2024-10-06T16:27:27-07:00" level=trace msg="emitting websocket event: playing" Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","play_origin":"playlist/ondemand"}} Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: PUSH STATE SPOTIFY Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: {"status":"play","service":"spop","title":"多謝你自己","artist":"Dear Jane","album":"多謝你自己","albumart":"https://i.scdn.co/image/ab67616d00001e020b0a54bc1303a2b0887d15cd","uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","trackType":"spotify","seek":0,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","play_origin":"playlist/ondemand"}} Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: PUSH STATE SPOTIFY Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: {"status":"play","service":"spop","title":"多謝你自己","artist":"Dear Jane","album":"多謝你自己","albumart":"https://i.scdn.co/image/ab67616d00001e020b0a54bc1303a2b0887d15cd","uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","trackType":"spotify","seek":0,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: PUSH STATE SPOTIFY Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: {"status":"play","service":"spop","title":"多謝你自己","artist":"Dear Jane","album":"多謝你自己","albumart":"https://i.scdn.co/image/ab67616d00001e020b0a54bc1303a2b0887d15cd","uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","trackType":"spotify","seek":0,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: PUSH STATE SPOTIFY Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: {"status":"play","service":"spop","title":"多謝你自己","artist":"Dear Jane","album":"多謝你自己","albumart":"https://i.scdn.co/image/ab67616d00001e020b0a54bc1303a2b0887d15cd","uri":"spotify:track:73HLm4bnp7QSnH8chPczoO","trackType":"spotify","seek":0,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:27:27 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:27:27 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:27:30 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:34 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:38 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:39 hifiguy go-librespot[1829]: time="2024-10-06T16:27:39-07:00" level=debug msg="fetched chunk 4/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:27:42 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:46 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:50 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:52 hifiguy go-librespot[1829]: time="2024-10-06T16:27:52-07:00" level=debug msg="fetched chunk 5/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:27:54 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:27:58 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:02 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:03 hifiguy go-librespot[1829]: time="2024-10-06T16:28:03-07:00" level=debug msg="fetched chunk 6/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:28:06 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:10 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:12 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Oct 06 16:28:12 hifiguy volumio[990]: info: Adding a new share Oct 06 16:28:12 hifiguy volumio[990]: info: No correspondence found in configuration for share media on IP 192.168.11.100 Oct 06 16:28:12 hifiguy sudo[2784]: 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.11.100/media\\HD-Music /mnt/NAS/media Oct 06 16:28:12 hifiguy sudo[2784]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 16:28:12 hifiguy kernel: Key type cifs.spnego registered Oct 06 16:28:12 hifiguy kernel: Key type cifs.idmap registered Oct 06 16:28:12 hifiguy kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 06 16:28:12 hifiguy kernel: CIFS: Attempting to mount \\192.168.11.100\media Oct 06 16:28:12 hifiguy sudo[2784]: pam_unix(sudo:session): session closed for user root Oct 06 16:28:12 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand status Oct 06 16:28:12 hifiguy volumio[990]: info: Oct 06 16:28:12 hifiguy volumio[990]: ---------------------------- MPD announces state update: update Oct 06 16:28:12 hifiguy volumio[990]: info: ControllerMpd::getState Oct 06 16:28:12 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand status Oct 06 16:28:12 hifiguy volumio[990]: info: sendMpdCommand status took 8 milliseconds Oct 06 16:28:12 hifiguy volumio[990]: verbose: ControllerMpd::parseState Oct 06 16:28:13 hifiguy volumio[990]: info: Command Router : Notfying DB Updatetrue Oct 06 16:28:13 hifiguy volumio[990]: info: [1728257293107] Database update started Oct 06 16:28:13 hifiguy volumio[990]: info: sendMpdCommand status took 505 milliseconds Oct 06 16:28:13 hifiguy volumio[990]: verbose: ControllerMpd::parseState Oct 06 16:28:13 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 16:28:13 hifiguy volumio[990]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 06 16:28:13 hifiguy volumio[990]: verbose: ControllerMpd::parseTrackInfo Oct 06 16:28:13 hifiguy volumio[990]: info: ControllerMpd::pushState Oct 06 16:28:13 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:28:13 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:28:13 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 16:28:13 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:28:13 hifiguy volumio[990]: info: CorePlayQueue::getTrack 0 Oct 06 16:28:13 hifiguy volumio[990]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 06 16:28:13 hifiguy volumio[990]: info: ------------------------------ 544ms Oct 06 16:28:13 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:28:13 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 06 16:28:14 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:15 hifiguy go-librespot[1829]: time="2024-10-06T16:28:15-07:00" level=debug msg="fetched chunk 7/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:28:18 hifiguy volumio[990]: info: MPD Database updated - AlbumList cache refreshed Oct 06 16:28:18 hifiguy volumio[990]: info: Oct 06 16:28:18 hifiguy volumio[990]: ---------------------------- MPD announces state update: database Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand status Oct 06 16:28:18 hifiguy volumio[990]: info: Oct 06 16:28:18 hifiguy volumio[990]: ---------------------------- MPD announces state update: update Oct 06 16:28:18 hifiguy volumio[990]: info: ControllerMpd::getState Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand status Oct 06 16:28:18 hifiguy volumio[990]: info: ControllerMpd::getState Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand status Oct 06 16:28:18 hifiguy volumio[990]: info: sendMpdCommand status took 22 milliseconds Oct 06 16:28:18 hifiguy volumio[990]: info: sendMpdCommand status took 24 milliseconds Oct 06 16:28:18 hifiguy volumio[990]: info: sendMpdCommand status took 24 milliseconds Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::parseState Oct 06 16:28:18 hifiguy volumio[990]: info: Command Router : Notfying DB Updatefalse Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::Close All Modals sent Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::parseState Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::parseState Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 16:28:18 hifiguy volumio[990]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 06 16:28:18 hifiguy volumio[990]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::parseTrackInfo Oct 06 16:28:18 hifiguy volumio[990]: verbose: ControllerMpd::parseTrackInfo Oct 06 16:28:18 hifiguy volumio[990]: info: ControllerMpd::pushState Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:28:18 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:28:18 hifiguy volumio[990]: info: CorePlayQueue::getTrack 0 Oct 06 16:28:18 hifiguy volumio[990]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 06 16:28:18 hifiguy volumio[990]: info: ControllerMpd::pushState Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::servicePushState Oct 06 16:28:18 hifiguy volumio[990]: info: CoreStateMachine::pushState Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::volumioPushState Oct 06 16:28:18 hifiguy volumio[990]: info: CorePlayQueue::getTrack 0 Oct 06 16:28:18 hifiguy volumio[990]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 06 16:28:18 hifiguy volumio[990]: info: ------------------------------ 137ms Oct 06 16:28:18 hifiguy volumio[990]: info: ------------------------------ 138ms Oct 06 16:28:18 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:28:18 hifiguy volumio[990]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Oct 06 16:28:18 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:22 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:26 hifiguy volumio[990]: info: CoreCommandRouter::volumioGetState Oct 06 16:28:27 hifiguy go-librespot[1829]: time="2024-10-06T16:28:27-07:00" level=debug msg="fetched chunk 8/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 16:28:31 hifiguy volumio[990]: info: Retrieving Cloud Streaming UI Oct 06 16:28:31 hifiguy volumio[990]: info: Getting Tidal Cloud Configuration Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 16:28:31 hifiguy volumio[990]: info: Getting Qobuz Cloud Configuration Oct 06 16:28:31 hifiguy volumio[990]: info: Asking plugin for UI Config Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 16:28:31 hifiguy volumio[990]: info: Getting Spotify Cloud Configuration Oct 06 16:28:31 hifiguy volumio[990]: info: Asking plugin for UI Config Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 16:28:31 hifiguy volumio[990]: info: Saving Spotify Acccount Oct 06 16:28:31 hifiguy volumio[990]: info: Got Tidal Cloud Configuration Oct 06 16:28:31 hifiguy volumio[990]: info: Got it Oct 06 16:28:31 hifiguy volumio[990]: info: Got it Oct 06 16:28:31 hifiguy volumio[990]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 16:28:31 hifiguy volumio[990]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 16:28:31 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 06 16:28:35 hifiguy volumio[990]: info: CoreCommandRouter::volumioGetState Oct 06 16:28:39 hifiguy go-librespot[1829]: time="2024-10-06T16:28:39-07:00" level=debug msg="fetched chunk 9/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:28:44 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 06 16:28:44 hifiguy volumio[990]: info: Preload queue cleared Oct 06 16:28:47 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 06 16:28:47 hifiguy volumio[990]: info: Preload queue cleared Oct 06 16:28:49 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 06 16:28:49 hifiguy volumio[990]: info: Preload queue cleared Oct 06 16:28:52 hifiguy go-librespot[1829]: time="2024-10-06T16:28:52-07:00" level=debug msg="fetched chunk 10/20, size: 524288" uri="spotify:track:73HLm4bnp7QSnH8chPczoO" Oct 06 16:28:54 hifiguy volumio[990]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 06 16:28:54 hifiguy volumio[990]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 16:28:54 hifiguy volumio[990]: TypeError: Cannot read property 'length' of undefined Oct 06 16:28:54 hifiguy volumio[990]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 06 16:28:54 hifiguy volumio[990]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 06 16:28:54 hifiguy volumio[990]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 06 16:28:54 hifiguy volumio[990]: at Parser.emit (events.js:315:20) Oct 06 16:28:54 hifiguy volumio[990]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 06 16:28:54 hifiguy volumio[990]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 06 16:28:54 hifiguy volumio[990]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 06 16:28:54 hifiguy volumio[990]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 06 16:28:54 hifiguy volumio[990]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 06 16:28:54 hifiguy volumio[990]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 06 16:28:54 hifiguy volumio[990]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 06 16:28:54 hifiguy volumio[990]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 06 16:28:54 hifiguy volumio[990]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 06 16:28:54 hifiguy volumio[990]: at IncomingMessage.emit (events.js:327:22) Oct 06 16:28:54 hifiguy volumio[990]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 06 16:28:54 hifiguy volumio[990]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 06 16:28:54 hifiguy volumio[990]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 16:28:55 hifiguy sudo[2854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 16:27 Oct 06 16:28:55 hifiguy sudo[2854]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"