-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Sun 2025-06-29 15:05:25 +07. -- Jun 29 15:04:06 volumio9 go-librespot[1132]: time="2025-06-29T15:04:06+07:00" level=debug msg="fetched chunk 5/17, size: 524288" uri="spotify:track:6JFB3zzyR5F84u8uSzKvYS" Jun 29 15:04:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 15:04:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 15:04:10 volumio9 volumio[825]: info: Discovery: Getting this device information Jun 29 15:04:10 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jun 29 15:04:10 volumio9 volumio[825]: info: CorePlayQueue::getTrack 196 Jun 29 15:04:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 15:04:11 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 29 15:04:11 volumio9 volumio[825]: info: Preload queue cleared Jun 29 15:04:13 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 29 15:04:13 volumio9 volumio[825]: error: Error browsing0:Error: Did not get expected response from server:{"html":{"$":{"xmlns":"http://www.w3.org/1999/xhtml","xml:lang":"en","lang":"en"},"head":[{"title":[{"_":"404 - Not Found"}]}],"body":[{"h1":[{"_":"404 - Not Found"}]}]}} Jun 29 15:04:13 volumio9 volumio[825]: error: Failed to execute browseSource: Jun 29 15:04:18 volumio9 go-librespot[1132]: time="2025-06-29T15:04:18+07:00" level=trace msg="sent dealer ping" Jun 29 15:04:18 volumio9 go-librespot[1132]: time="2025-06-29T15:04:18+07:00" level=trace msg="received dealer pong" Jun 29 15:04:19 volumio9 go-librespot[1132]: time="2025-06-29T15:04:19+07:00" level=debug msg="fetched chunk 6/17, size: 524288" uri="spotify:track:6JFB3zzyR5F84u8uSzKvYS" Jun 29 15:04:21 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 29 15:04:21 volumio9 volumio[825]: info: CURURI: music-library Jun 29 15:04:21 volumio9 volumio[825]: info: Preload queue cleared Jun 29 15:04:30 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 29 15:04:30 volumio9 volumio[825]: info: CURURI: music-library/NAS Jun 29 15:04:30 volumio9 volumio[825]: info: Preload queue cleared Jun 29 15:04:32 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 29 15:04:32 volumio9 volumio[825]: info: CURURI: music-library/NAS/Storage2 Jun 29 15:04:32 volumio9 volumio[825]: info: Preload queue cleared Jun 29 15:04:33 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 29 15:04:33 volumio9 volumio[825]: info: CURURI: music-library/NAS/Storage2/FLAC Jun 29 15:04:33 volumio9 volumio[825]: info: Preload queue cleared Jun 29 15:04:33 volumio9 go-librespot[1132]: time="2025-06-29T15:04:33+07:00" level=debug msg="fetched chunk 7/17, size: 524288" uri="spotify:track:6JFB3zzyR5F84u8uSzKvYS" Jun 29 15:04:40 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 15:04:40 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 15:04:40 volumio9 volumio[825]: info: Discovery: Getting this device information Jun 29 15:04:40 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jun 29 15:04:40 volumio9 volumio[825]: info: CorePlayQueue::getTrack 196 Jun 29 15:04:40 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 15:04:46 volumio9 go-librespot[1132]: time="2025-06-29T15:04:46+07:00" level=debug msg="fetched chunk 8/17, size: 524288" uri="spotify:track:6JFB3zzyR5F84u8uSzKvYS" Jun 29 15:04:48 volumio9 go-librespot[1132]: time="2025-06-29T15:04:48+07:00" level=trace msg="sent dealer ping" Jun 29 15:04:48 volumio9 go-librespot[1132]: time="2025-06-29T15:04:48+07:00" level=trace msg="received dealer pong" Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 15:04:50 volumio9 volumio[825]: info: Retrieving Cloud Streaming UI Jun 29 15:04:50 volumio9 volumio[825]: info: Getting Tidal Cloud Configuration Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 15:04:50 volumio9 volumio[825]: info: Getting Qobuz Cloud Configuration Jun 29 15:04:50 volumio9 volumio[825]: info: Asking plugin for UI Config Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 15:04:50 volumio9 volumio[825]: info: Getting Spotify Cloud Configuration Jun 29 15:04:50 volumio9 volumio[825]: info: Asking plugin for UI Config Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 15:04:50 volumio9 volumio[825]: info: Saving Spotify Acccount Jun 29 15:04:50 volumio9 volumio[825]: info: Got Tidal Cloud Configuration Jun 29 15:04:50 volumio9 volumio[825]: info: Got it Jun 29 15:04:50 volumio9 volumio[825]: info: Got it Jun 29 15:04:50 volumio9 volumio[825]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 15:04:50 volumio9 volumio[825]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetBrowseSources Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetBrowseSources Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetBrowseSources Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:04:50 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 29 15:04:54 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:04:59 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:04:59 volumio9 go-librespot[1132]: time="2025-06-29T15:04:59+07:00" level=debug msg="fetched chunk 9/17, size: 524288" uri="spotify:track:6JFB3zzyR5F84u8uSzKvYS" Jun 29 15:05:02 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:05:06 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:05:07 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jun 29 15:05:07 volumio9 volumio[825]: info: Share Storage2 successfully unmounted Jun 29 15:05:07 volumio9 sudo[18212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Santichai,password=MmXp3152,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.12/Hires /mnt/NAS/Storage2 Jun 29 15:05:07 volumio9 sudo[18212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 15:05:07 volumio9 kernel: CIFS: Attempting to mount //192.168.1.12/Hires Jun 29 15:05:07 volumio9 sudo[18212]: pam_unix(sudo:session): session closed for user root Jun 29 15:05:07 volumio9 volumio[825]: info: An error occurred mounting the new share. Rolling back configuration Jun 29 15:05:07 volumio9 kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.12\Hires Jun 29 15:05:07 volumio9 kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Jun 29 15:05:08 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 29 15:05:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:05:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 15:05:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 15:05:10 volumio9 volumio[825]: info: Discovery: Getting this device information Jun 29 15:05:10 volumio9 volumio[825]: info: CoreCommandRouter::volumioGetState Jun 29 15:05:10 volumio9 volumio[825]: info: CorePlayQueue::getTrack 196 Jun 29 15:05:10 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 15:05:12 volumio9 go-librespot[1132]: time="2025-06-29T15:05:12+07:00" level=debug msg="fetched chunk 10/17, size: 524288" uri="spotify:track:6JFB3zzyR5F84u8uSzKvYS" Jun 29 15:05:14 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:05:18 volumio9 go-librespot[1132]: time="2025-06-29T15:05:18+07:00" level=trace msg="received accesspoint ping" Jun 29 15:05:18 volumio9 go-librespot[1132]: time="2025-06-29T15:05:18+07:00" level=trace msg="received accesspoint pong ack" Jun 29 15:05:18 volumio9 go-librespot[1132]: time="2025-06-29T15:05:18+07:00" level=trace msg="sent dealer ping" Jun 29 15:05:18 volumio9 go-librespot[1132]: time="2025-06-29T15:05:18+07:00" level=trace msg="received dealer pong" Jun 29 15:05:18 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:05:22 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jun 29 15:05:22 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 15:05:23 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 29 15:05:24 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jun 29 15:05:24 volumio9 volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jun 29 15:05:25 volumio9 volumio[825]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 15:05:25 volumio9 volumio[825]: Error: getaddrinfo -3007 Jun 29 15:05:25 volumio9 volumio[825]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Jun 29 15:05:25 volumio9 volumio[825]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Jun 29 15:05:25 volumio9 volumio[825]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Jun 29 15:05:25 volumio9 volumio[825]: code: -3007, Jun 29 15:05:25 volumio9 volumio[825]: errno: -3007, Jun 29 15:05:25 volumio9 volumio[825]: syscall: 'getaddrinfo' Jun 29 15:05:25 volumio9 volumio[825]: } Jun 29 15:05:25 volumio9 volumio[825]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 15:05:25 volumio9 sudo[18293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-29 15:04 Jun 29 15:05:25 volumio9 sudo[18293]: 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="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"