Dec 28 15:41:00 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Dec 28 15:41:00 living-room volumio[1187]: info: Share Diskstation successfully unmounted Dec 28 15:41:00 living-room sudo[2923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=pserra77,password=Min3Cr@ft9,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.25//music/music /mnt/NAS/Diskstation Dec 28 15:41:00 living-room sudo[2923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:41:00 living-room sudo[2923]: pam_unix(sudo:session): session closed for user root Dec 28 15:41:00 living-room kernel: Malformed UNC in devname Dec 28 15:41:00 living-room kernel: CIFS: VFS: Malformed UNC in devname Dec 28 15:41:00 living-room volumio[1187]: info: An error occurred mounting the new share. Rolling back configuration Dec 28 15:41:01 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 28 15:41:02 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:05 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 28 15:41:05 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 28 15:41:06 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:07 living-room volumio[1187]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L DiskStation.local. -m SMB3_11 Dec 28 15:41:07 living-room volumio[1187]: info: Error browsing device DiskStation for shares: Command failed: smbclient --no-pass --debuglevel=0 -L DiskStation.local. -m SMB3_11 Dec 28 15:41:10 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:12 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Dec 28 15:41:13 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 28 15:41:14 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:18 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:22 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:26 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:30 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:34 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:38 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:39 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Dec 28 15:41:39 living-room volumio[1187]: info: Adding a new share Dec 28 15:41:39 living-room volumio[1187]: info: No correspondence found in configuration for share Diskstation on IP 192.168.1.25 Dec 28 15:41:39 living-room volumio[1187]: info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.1.25 -N -m SMB3_11 Dec 28 15:41:40 living-room volumio[1187]: info: Error browsing device Diskstation for shares: Command failed: smbclient --debuglevel=4 -L 192.168.1.25 -N -m SMB3_11 Dec 28 15:41:40 living-room volumio[1187]: lp_load_ex: refreshing parameters Dec 28 15:41:40 living-room volumio[1187]: Initialising global parameters Dec 28 15:41:40 living-room volumio[1187]: Processing section "[global]" Dec 28 15:41:40 living-room volumio[1187]: doing parameter netbios name = Living Room Dec 28 15:41:40 living-room volumio[1187]: doing parameter server string = Audiophile Music Player Dec 28 15:41:40 living-room volumio[1187]: doing parameter workgroup = WORKGROUP Dec 28 15:41:40 living-room volumio[1187]: doing parameter security = user Dec 28 15:41:40 living-room volumio[1187]: doing parameter map to guest = Bad User Dec 28 15:41:40 living-room volumio[1187]: doing parameter encrypt passwords = yes Dec 28 15:41:40 living-room volumio[1187]: lpcfg_do_global_parameter: WARNING: The "encrypt passwords" option is deprecated Dec 28 15:41:40 living-room volumio[1187]: doing parameter wins support = yes Dec 28 15:41:40 living-room volumio[1187]: doing parameter local master = no Dec 28 15:41:40 living-room volumio[1187]: doing parameter preferred master = no Dec 28 15:41:40 living-room volumio[1187]: doing parameter os level = 30 Dec 28 15:41:40 living-room volumio[1187]: pm_process() returned Yes Dec 28 15:41:40 living-room volumio[1187]: added interface eth0 ip=192.168.1.102 bcast=192.168.1.255 netmask=255.255.255.0 Dec 28 15:41:40 living-room volumio[1187]: Client started (version 4.17.8-Raspbian). Dec 28 15:41:40 living-room volumio[1187]: Connecting to 192.168.1.25 at port 445 Dec 28 15:41:40 living-room volumio[1187]: session request ok Dec 28 15:41:40 living-room volumio[1187]: negotiated dialect[SMB3_11] against server[192.168.1.25] Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'gssapi_spnego' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'gssapi_krb5' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'gssapi_krb5_sasl' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'spnego' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'schannel' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'ncalrpc_as_system' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'sasl-EXTERNAL' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'ntlmssp' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'ntlmssp_resume_ccache' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'http_basic' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'http_ntlm' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'http_negotiate' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'krb5' registered Dec 28 15:41:40 living-room volumio[1187]: GENSEC backend 'fake_gssapi_krb5' registered Dec 28 15:41:40 living-room volumio[1187]: Cannot do GSE to an IP address Dec 28 15:41:40 living-room volumio[1187]: Failed to start GENSEC client mech gse_krb5: NT_STATUS_INVALID_PARAMETER Dec 28 15:41:40 living-room volumio[1187]: Got challenge flags: Dec 28 15:41:40 living-room volumio[1187]: Got NTLMSSP neg_flags=0x628a8215 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_UNICODE Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_REQUEST_TARGET Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_NTLM Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_ALWAYS_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_TARGET_TYPE_SERVER Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_TARGET_INFO Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_VERSION Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_128 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_KEY_EXCH Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP: Set final flags: Dec 28 15:41:40 living-room volumio[1187]: Got NTLMSSP neg_flags=0x62008215 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_UNICODE Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_REQUEST_TARGET Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_NTLM Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_ALWAYS_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_VERSION Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_128 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_KEY_EXCH Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP Sign/Seal - Initialising with flags: Dec 28 15:41:40 living-room volumio[1187]: Got NTLMSSP neg_flags=0x62008215 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_UNICODE Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_REQUEST_TARGET Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_NTLM Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_ALWAYS_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_VERSION Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_128 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_KEY_EXCH Dec 28 15:41:40 living-room volumio[1187]: SPNEGO login failed: The attempted logon is invalid. This is either due to a bad username or authentication information. Dec 28 15:41:40 living-room volumio[1187]: Got challenge flags: Dec 28 15:41:40 living-room volumio[1187]: Got NTLMSSP neg_flags=0x628a8215 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_UNICODE Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_REQUEST_TARGET Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_NTLM Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_ALWAYS_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_TARGET_TYPE_SERVER Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_EXTENDED_SESSIONSECURITY Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_TARGET_INFO Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_VERSION Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_128 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_KEY_EXCH Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP: Set final flags: Dec 28 15:41:40 living-room volumio[1187]: Got NTLMSSP neg_flags=0x62008a15 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_UNICODE Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_REQUEST_TARGET Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_NTLM Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_ANONYMOUS Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_ALWAYS_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_VERSION Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_128 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_KEY_EXCH Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP Sign/Seal - Initialising with flags: Dec 28 15:41:40 living-room volumio[1187]: Got NTLMSSP neg_flags=0x62008a15 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_UNICODE Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_REQUEST_TARGET Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_NTLM Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_ANONYMOUS Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_ALWAYS_SIGN Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_VERSION Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_128 Dec 28 15:41:40 living-room volumio[1187]: NTLMSSP_NEGOTIATE_KEY_EXCH Dec 28 15:41:40 living-room volumio[1187]: SPNEGO login failed: The attempted logon is invalid. This is either due to a bad username or authentication information. Dec 28 15:41:40 living-room volumio[1187]: info: Detected device Diskstation with version null Dec 28 15:41:40 living-room sudo[3011]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.25/Music /mnt/NAS/Diskstation Dec 28 15:41:40 living-room sudo[3011]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:41:40 living-room 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. Dec 28 15:41:40 living-room kernel: CIFS: Attempting to mount //192.168.1.25/Music Dec 28 15:41:40 living-room kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Dec 28 15:41:40 living-room kernel: CIFS: VFS: \\192.168.1.25 Send error in SessSetup = -13 Dec 28 15:41:40 living-room kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Dec 28 15:41:40 living-room sudo[3011]: pam_unix(sudo:session): session closed for user root Dec 28 15:41:40 living-room volumio[1187]: info: Permission denied for Diskstation on IP 192.168.1.25 Dec 28 15:41:41 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 28 15:41:42 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:46 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:50 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:54 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:57 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Dec 28 15:41:57 living-room volumio[1187]: info: Share Diskstation successfully unmounted Dec 28 15:41:57 living-room sudo[3060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=pserra77,password=Min3Cr@ft9,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.25/Music /mnt/NAS/Diskstation Dec 28 15:41:57 living-room sudo[3060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:41:57 living-room kernel: CIFS: Attempting to mount //192.168.1.25/Music Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:41:58 living-room sudo[3060]: pam_unix(sudo:session): session closed for user root Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Dec 28 15:41:58 living-room volumio[1187]: info: Dec 28 15:41:58 living-room volumio[1187]: ---------------------------- MPD announces state update: update Dec 28 15:41:58 living-room volumio[1187]: info: ControllerMpd::getState Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Dec 28 15:41:58 living-room volumio[1187]: info: Dec 28 15:41:58 living-room volumio[1187]: ---------------------------- MPD announces state update: update Dec 28 15:41:58 living-room volumio[1187]: info: ControllerMpd::getState Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::sendMpdCommand status Dec 28 15:41:58 living-room volumio[1187]: info: sendMpdCommand status took 20 milliseconds Dec 28 15:41:58 living-room volumio[1187]: info: sendMpdCommand status took 16 milliseconds Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::parseState Dec 28 15:41:58 living-room systemd[1]: Starting fstrim.service - Discard unused blocks on filesystems from /etc/fstab... Dec 28 15:41:58 living-room volumio[1187]: info: Command Router : Notfying DB Updatetrue Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::parseState Dec 28 15:41:58 living-room volumio[1187]: info: ControllerMpd::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::servicePushState Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::volumioPushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 28 15:41:58 living-room volumio[1187]: verbose: CURRENT POSITION 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::syncState stateService stop Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::volumioPushState Dec 28 15:41:58 living-room volumio[1187]: info: No code Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::volumioPushState Dec 28 15:41:58 living-room volumio[1187]: info: ------------------------------ 205ms Dec 28 15:41:58 living-room volumio[1187]: info: [1766916718397] Database update started Dec 28 15:41:58 living-room volumio[1187]: info: sendMpdCommand status took 229 milliseconds Dec 28 15:41:58 living-room volumio[1187]: info: sendMpdCommand status took 218 milliseconds Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::parseState Dec 28 15:41:58 living-room volumio[1187]: info: Command Router : Notfying DB Updatetrue Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::Close All Modals sent Dec 28 15:41:58 living-room volumio[1187]: verbose: ControllerMpd::parseState Dec 28 15:41:58 living-room volumio[1187]: info: ControllerMpd::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::servicePushState Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::volumioPushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 28 15:41:58 living-room volumio[1187]: verbose: CURRENT POSITION 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::syncState stateService stop Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::syncState currentStatus stop Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::volumioPushState Dec 28 15:41:58 living-room volumio[1187]: info: No code Dec 28 15:41:58 living-room volumio[1187]: info: CoreStateMachine::pushState Dec 28 15:41:58 living-room volumio[1187]: info: CorePlayQueue::getTrack 0 Dec 28 15:41:58 living-room volumio[1187]: info: CoreCommandRouter::volumioPushState Dec 28 15:41:58 living-room volumio[1187]: info: ------------------------------ 353ms Dec 28 15:41:58 living-room fstrim[3069]: /boot: 273.6 MiB (286883840 bytes) trimmed on /dev/mmcblk0p1 Dec 28 15:41:58 living-room systemd[1]: fstrim.service: Deactivated successfully. Dec 28 15:41:58 living-room systemd[1]: Finished fstrim.service - Discard unused blocks on filesystems from /etc/fstab. Dec 28 15:41:59 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 28 15:42:02 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:42:06 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:42:10 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:42:14 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:42:18 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 28 15:42:20 living-room volumio[1187]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 28 15:42:20 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 28 15:42:20 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 28 15:42:21 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 28 15:42:21 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 28 15:42:21 living-room sudo[3158]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 28 15:42:21 living-room sudo[3169]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 28 15:42:21 living-room sudo[3169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3163]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 28 15:42:21 living-room sudo[3163]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3173]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 28 15:42:21 living-room sudo[3173]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3173]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room sudo[3163]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room sudo[3169]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room sudo[3178]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 28 15:42:21 living-room sudo[3178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3158]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room sudo[3180]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 28 15:42:21 living-room sudo[3178]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room sudo[3180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3180]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room sudo[3186]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 28 15:42:21 living-room sudo[3186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3186]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room volumio[1187]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 28 15:42:21 living-room volumio[1187]: wlan0 Interface doesn't support scanning : Network is down Dec 28 15:42:21 living-room volumio[1187]: info: Cannot use regular scanning, forcing with ap-force Dec 28 15:42:21 living-room sudo[3194]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 28 15:42:21 living-room sudo[3194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:21 living-room sudo[3194]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:21 living-room volumio[1187]: command failed: Network is down (-100) Dec 28 15:42:21 living-room volumio[1187]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 28 15:42:21 living-room volumio[1187]: command failed: Network is down (-100) Dec 28 15:42:34 living-room volumio[1187]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Dec 28 15:42:34 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Dec 28 15:42:34 living-room sudo[3217]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Dec 28 15:42:34 living-room sudo[3217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:34 living-room sudo[3217]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:34 living-room sudo[3219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Dec 28 15:42:34 living-room sudo[3219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:34 living-room sudo[3219]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:34 living-room volumio[1187]: info: Permissions for /etc/network/interfaces set Dec 28 15:42:34 living-room volumio[1187]: info: Restarting Wireless Network Dec 28 15:42:34 living-room volumio[1187]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 28 15:42:34 living-room volumio[1187]: info: Discovery: Restarting Advertising due to device name change Dec 28 15:42:35 living-room sudo[3222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 28 15:42:35 living-room sudo[3222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:35 living-room systemd[1]: Stopping wireless.service - Wireless Services... Dec 28 15:42:35 living-room systemd[1]: wireless.service: Deactivated successfully. Dec 28 15:42:35 living-room systemd[1]: Stopped wireless.service - Wireless Services. Dec 28 15:42:35 living-room systemd[1]: wireless.service: Consumed 7min 21.730s CPU time. Dec 28 15:42:35 living-room systemd[1]: Starting wireless.service - Wireless Services... Dec 28 15:42:35 living-room volumio[1187]: info: Discovery: A device disappeared from network Dec 28 15:42:36 living-room volumio[1187]: info: Discovery: A device disappeared from network Dec 28 15:42:36 living-room wireless.js[3227]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 28 15:42:36 living-room wireless.js[3227]: WIRELESS.JS: Wired network status changed to: ---connected--- Dec 28 15:42:36 living-room wireless.js[3227]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 28 15:42:36 living-room wireless.js[3227]: WIRELESS.JS: Cleaning previous... Dec 28 15:42:36 living-room sudo[3246]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 28 15:42:36 living-room sudo[3246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 28 15:42:36 living-room sudo[3246]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:37 living-room sudo[3248]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 28 15:42:37 living-room sudo[3248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 28 15:42:37 living-room sudo[3248]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:37 living-room wireless.js[3227]: WIRELESS.JS: Stopped aP Dec 28 15:42:37 living-room sudo[3256]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 28 15:42:37 living-room sudo[3256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 28 15:42:37 living-room sudo[3256]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:37 living-room wireless.js[3227]: SIOCSIFFLAGS: Operation not possible due to RF-kill Dec 28 15:42:37 living-room wireless.js[3227]: WIRELESS.JS: Failed to determine most appropriate reg domain: Error: Command failed: /usr/bin/sudo /sbin/ifconfig wlan0 up && /usr/bin/sudo /sbin/iw reg get | grep country | cut -f1 -d':' Dec 28 15:42:37 living-room wireless.js[3227]: SIOCSIFFLAGS: Operation not possible due to RF-kill Dec 28 15:42:37 living-room wireless.js[3227]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Dec 28 15:42:37 living-room wireless.js[3227]: WIRELESS.JS: Notified systemd about wireless ready Dec 28 15:42:37 living-room systemd[1]: Started wireless.service - Wireless Services. Dec 28 15:42:37 living-room sudo[3222]: pam_unix(sudo:session): session closed for user root Dec 28 15:42:39 living-room volumio[1187]: info: Discovery: Started advertising with name: Living Room Dec 28 15:42:40 living-room volumio[1187]: compat.c: read() failed: Resource temporarily unavailable Dec 28 15:42:40 living-room volumio[1187]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 28 15:42:41 living-room volumio[1187]: Error: dns service error: unknown Dec 28 15:42:41 living-room volumio[1187]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 28 15:42:41 living-room volumio[1187]: errorCode: -65537 Dec 28 15:42:41 living-room volumio[1187]: } Dec 28 15:42:41 living-room volumio[1187]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 28 15:42:42 living-room sudo[3295]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-28 15:41' Dec 28 15:42:42 living-room sudo[3295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"