-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Thu 2025-08-07 03:35:31 UTC. -- Aug 07 03:34:00 volumio---downstairs sudo[1824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 07 03:34:00 volumio---downstairs sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:00 volumio---downstairs sudo[1824]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:00 volumio---downstairs sudo[1826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 07 03:34:00 volumio---downstairs sudo[1826]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:00 volumio---downstairs sudo[1826]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:00 volumio---downstairs sudo[1729]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:00 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:34:00 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:34:00 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/music Aug 07 03:34:00 volumio---downstairs volumio[1677]: info: Cannot mount NAS Albums at system boot, trial number 1 ,retrying in 5 seconds Aug 07 03:34:00 volumio---downstairs sudo[1830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 07 03:34:00 volumio---downstairs sudo[1830]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:00 volumio---downstairs sudo[1830]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:00 volumio---downstairs volumio[1677]: info: Upmpdcli Daemon Started Aug 07 03:34:02 volumio---downstairs dhcpcd[1038]: eth0: leased 192.168.100.108 for 14400 seconds Aug 07 03:34:02 volumio---downstairs dhcpcd[978]: eth0: leased 192.168.100.108 for 14400 seconds Aug 07 03:34:02 volumio---downstairs dhcpcd[1038]: eth0: adding route to 192.168.100.0/24 Aug 07 03:34:02 volumio---downstairs dhcpcd[1038]: eth0: changing default route via 192.168.100.1 Aug 07 03:34:02 volumio---downstairs avahi-daemon[653]: Registering new address record for 192.168.100.108 on eth0.IPv4. Aug 07 03:34:02 volumio---downstairs dhcpcd[978]: eth0: adding route to 192.168.100.0/24 Aug 07 03:34:02 volumio---downstairs dhcpcd[978]: eth0: changing default route via 192.168.100.1 Aug 07 03:34:02 volumio---downstairs dhcpcd[1038]: eth0: deleting route to 169.254.0.0/16 Aug 07 03:34:02 volumio---downstairs avahi-daemon[653]: Withdrawing address record for 169.254.160.84 on eth0. Aug 07 03:34:02 volumio---downstairs dhcpcd[978]: eth0: deleting route to 169.254.0.0/16 Aug 07 03:34:02 volumio---downstairs avahi-daemon[653]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.160.84. Aug 07 03:34:02 volumio---downstairs avahi-daemon[653]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.100.108. Aug 07 03:34:02 volumio---downstairs dhcpcd[1038]: eth0: pid 1038 deleted default route via 192.168.100.1 Aug 07 03:34:02 volumio---downstairs dhcpcd[1038]: eth0: adding default route via 192.168.100.1 Aug 07 03:34:02 volumio---downstairs dhcpcd[978]: eth0: pid 1038 deleted default route via 192.168.100.1 Aug 07 03:34:03 volumio---downstairs ntpd[788]: Listen normally on 5 eth0 192.168.100.108:123 Aug 07 03:34:03 volumio---downstairs ntpd[788]: Deleting interface #3 eth0, 169.254.160.84#123, interface stats: received=0, sent=0, dropped=0, active_time=133 secs Aug 07 03:34:03 volumio---downstairs ntpd[788]: new interface(s) found: waking up resolver Aug 07 03:34:04 volumio---downstairs ntpd[788]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 07 03:34:04 volumio---downstairs ntpd[788]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Aug 07 03:34:04 volumio---downstairs ntpd[788]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 07 03:34:04 volumio---downstairs ntpd[788]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 07 03:34:04 volumio---downstairs ntpd[788]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 07 03:34:05 volumio---downstairs dhcpcd[1038]: wlan0: leased 192.168.100.109 for 14400 seconds Aug 07 03:34:05 volumio---downstairs avahi-daemon[653]: Registering new address record for 192.168.100.109 on wlan0.IPv4. Aug 07 03:34:05 volumio---downstairs dhcpcd[1038]: wlan0: adding route to 192.168.100.0/24 Aug 07 03:34:05 volumio---downstairs dhcpcd[1038]: wlan0: adding default route via 192.168.100.1 Aug 07 03:34:05 volumio---downstairs sudo[1920]: 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.100.163/jules/albums /mnt/NAS/Albums Aug 07 03:34:05 volumio---downstairs sudo[1920]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:05 volumio---downstairs avahi-daemon[653]: Withdrawing address record for 169.254.217.25 on wlan0. Aug 07 03:34:05 volumio---downstairs avahi-daemon[653]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.217.25. Aug 07 03:34:05 volumio---downstairs dhcpcd[1038]: wlan0: deleting route to 169.254.0.0/16 Aug 07 03:34:05 volumio---downstairs avahi-daemon[653]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.109. Aug 07 03:34:06 volumio---downstairs ntpd[788]: Listen normally on 6 wlan0 192.168.100.109:123 Aug 07 03:34:06 volumio---downstairs ntpd[788]: Deleting interface #4 wlan0, 169.254.217.25#123, interface stats: received=0, sent=0, dropped=0, active_time=126 secs Aug 07 03:34:06 volumio---downstairs ntpd[788]: new interface(s) found: waking up resolver Aug 07 03:34:10 volumio---downstairs sudo[1731]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Completed loading Core Plugins Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Preparing to generate the ALSA configuration file Aug 07 03:34:10 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:34:10 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:34:10 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/albums Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Asound.conf file unchanged, so no further update is needed Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Output device has changed, restarting MPD Aug 07 03:34:10 volumio---downstairs sudo[1976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Output device has changed, restarting Shairport Sync Aug 07 03:34:10 volumio---downstairs sudo[1976]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:10 volumio---downstairs sudo[1976]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:10 volumio---downstairs sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 07 03:34:10 volumio---downstairs sudo[1978]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs systemd[1]: Stopping Music Player Daemon... Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: ___________ START PLUGINS ___________ Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: ControllerMpd::onStart: Initializing MPD Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Creating MPD Configuration file Aug 07 03:34:10 volumio---downstairs systemd[1]: mpd.service: Succeeded. Aug 07 03:34:10 volumio---downstairs systemd[1]: Stopped Music Player Daemon. Aug 07 03:34:10 volumio---downstairs sudo[1985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 07 03:34:10 volumio---downstairs sudo[1985]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [1754537650453] CoreMusicLibrary::Adding element Media Servers Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:10 volumio---downstairs systemd[1]: Starting Music Player Daemon... Aug 07 03:34:10 volumio---downstairs sudo[1985]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:10 volumio---downstairs sudo[1988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 07 03:34:10 volumio---downstairs sudo[1988]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:10 volumio---downstairs systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 07 03:34:10 volumio---downstairs systemd[1]: mpd.service: Succeeded. Aug 07 03:34:10 volumio---downstairs systemd[1]: Stopped Music Player Daemon. Aug 07 03:34:10 volumio---downstairs systemd[1]: Starting Music Player Daemon... Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [1754537650540] CoreMusicLibrary::Adding element Last_100 Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [1754537650542] CoreMusicLibrary::Adding element Webradio Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Initializing BBC Radios Aug 07 03:34:10 volumio---downstairs sudo[1995]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 07 03:34:10 volumio---downstairs sudo[1995]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs sudo[1995]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [1754537650604] CoreMusicLibrary::Adding element Mother Earth Radio Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 07 03:34:10 volumio---downstairs volumio[1677]: Cannot find translation for source Mother Earth Radio Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [1754537650607] CoreMusicLibrary::Adding element Radio Paradise Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 07 03:34:10 volumio---downstairs volumio[1677]: Cannot find translation for source Mother Earth Radio Aug 07 03:34:10 volumio---downstairs volumio[1677]: Cannot find translation for source Radio Paradise Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [1754537650610] CoreMusicLibrary::Adding element LastFM Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 07 03:34:10 volumio---downstairs volumio[1677]: Cannot find translation for source Mother Earth Radio Aug 07 03:34:10 volumio---downstairs volumio[1677]: Cannot find translation for source Radio Paradise Aug 07 03:34:10 volumio---downstairs volumio[1677]: Cannot find translation for source LastFM Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [LastFM] scrobbler initiated! Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [LastFM] extended logging: false Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [LastFM] try scrobble stream/radio plays: true Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [LastFM] Left init routine Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: [LastFM] Socket already connected: true Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Volumio Calling Home Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: MPD Permissions set Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: MPD Permissions set Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Starting Shairport Sync Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Starting Shairport Sync Aug 07 03:34:10 volumio---downstairs sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 07 03:34:10 volumio---downstairs volumio[1677]: info: Starting Shairport Sync Aug 07 03:34:10 volumio---downstairs sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs sudo[2024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 07 03:34:10 volumio---downstairs sudo[2024]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs sudo[2027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 07 03:34:10 volumio---downstairs sudo[2027]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:10 volumio---downstairs systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 07 03:34:10 volumio---downstairs systemd[1]: shairport-sync.service: Succeeded. Aug 07 03:34:10 volumio---downstairs systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 07 03:34:11 volumio---downstairs sudo[2024]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:11 volumio---downstairs systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 07 03:34:11 volumio---downstairs sudo[2022]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: Shairport-Sync Started Aug 07 03:34:11 volumio---downstairs systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 07 03:34:11 volumio---downstairs systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 07 03:34:11 volumio---downstairs systemd[1]: shairport-sync.service: Succeeded. Aug 07 03:34:11 volumio---downstairs systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 07 03:34:11 volumio---downstairs volumio[1677]: Error adding Membership: Error: addMembership EINVAL Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: Shairport-Sync Started Aug 07 03:34:11 volumio---downstairs systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 07 03:34:11 volumio---downstairs sudo[2027]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: Shairport-Sync Started Aug 07 03:34:11 volumio---downstairs mpd[2006]: Aug 07 03:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 07 03:34:11 volumio---downstairs systemd[1]: Started Music Player Daemon. Aug 07 03:34:11 volumio---downstairs sudo[1988]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:11 volumio---downstairs sudo[1978]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: Completed starting Core Plugins Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: ------------------------------------------- Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: ----- MyVolumio plugins startup ---- Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: ------------------------------------------- Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 07 03:34:11 volumio---downstairs volumio[1677]: error: MPD error: The expression evaluated to a falsy value: Aug 07 03:34:11 volumio---downstairs volumio[1677]: assert.ok(self.idling) Aug 07 03:34:11 volumio---downstairs volumio[1677]: error: The expression evaluated to a falsy value: Aug 07 03:34:11 volumio---downstairs volumio[1677]: assert.ok(self.idling) Aug 07 03:34:11 volumio---downstairs volumio[1677]: error: updateQueue error: null Aug 07 03:34:11 volumio---downstairs volumio[1677]: info: MPD running with PID2006 Aug 07 03:34:11 volumio---downstairs volumio[1677]: ,establishing connection Aug 07 03:34:11 volumio---downstairs volumio[1677]: error: updateQueue error: null Aug 07 03:34:11 volumio---downstairs volumio-time-update[650]: volumio-time-update-util: Date not found in response Aug 07 03:34:11 volumio---downstairs volumio-time-update[650]: volumio-time-update-util: Retrying in 5 seconds... Aug 07 03:34:15 volumio---downstairs sudo[2040]: 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.100.163/jules/music /mnt/NAS/Music Aug 07 03:34:15 volumio---downstairs sudo[2040]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:16 volumio---downstairs volumio[1677]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 07 03:34:16 volumio---downstairs volumio-time-update[650]: volumio-time-update-util: Fetching time from Volumio... Aug 07 03:34:20 volumio---downstairs sudo[1920]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:20 volumio---downstairs volumio[1677]: info: Cannot mount NAS Albums at system boot, trial number 2 ,retrying in 5 seconds Aug 07 03:34:20 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:34:20 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:34:20 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/music Aug 07 03:34:25 volumio---downstairs sudo[2066]: 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.100.163/jules/albums /mnt/NAS/Albums Aug 07 03:34:25 volumio---downstairs sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:30 volumio---downstairs sudo[2040]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:30 volumio---downstairs volumio[1677]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds Aug 07 03:34:30 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:34:30 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:34:30 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/albums Aug 07 03:34:31 volumio---downstairs volumio[1677]: error: MyVolumio Plugin failed to start in a timely fashion Aug 07 03:34:31 volumio---downstairs volumio[1677]: [Metrics] CommandRouter: 42s 455.32ms Aug 07 03:34:31 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumiosetStartupVolume Aug 07 03:34:31 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 07 03:34:31 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:31 volumio---downstairs volumio[1677]: info: CoreCommandRouter::Close All Modals sent Aug 07 03:34:31 volumio---downstairs volumio[1677]: info: CoreCommandRouter::Close All Modals sent Aug 07 03:34:32 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 07 03:34:32 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 07 03:34:32 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: Discovery: adding d28b0c2e-725b-4dd1-94bb-5b102833f0c5 Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: Discovery: Found device Volumio - Downstairs Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioGetState Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: CorePlayQueue::getTrack 0 Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: Discovery: this is already registered, d28b0c2e-725b-4dd1-94bb-5b102833f0c5 Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: Discovery: Found device Volumio - Downstairs Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: CoreCommandRouter::volumioGetState Aug 07 03:34:35 volumio---downstairs volumio[1677]: info: CorePlayQueue::getTrack 0 Aug 07 03:34:35 volumio---downstairs volumio[1677]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 07 03:34:35 volumio---downstairs sudo[2090]: 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.100.163/jules/music /mnt/NAS/Music Aug 07 03:34:35 volumio---downstairs sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:36 volumio---downstairs volumiologrotate[658]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Aug 07 03:34:36 volumio---downstairs volumiologrotate[658]: ls: cannot access '-': No such file or directory Aug 07 03:34:36 volumio---downstairs volumiologrotate[658]: ls: cannot access 'DOWNSTAIRS': No such file or directory Aug 07 03:34:36 volumio---downstairs kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Aug 07 03:34:36 volumio---downstairs kernel: xhci_hcd 0000:01:00.0: @0000000429518470 00000000 00000000 0e000000 02028001 Aug 07 03:34:38 volumio---downstairs volumio[1677]: info: BOOT COMPLETED Aug 07 03:34:40 volumio---downstairs sudo[2066]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:40 volumio---downstairs volumio[1677]: info: Cannot mount NAS Albums at system boot, trial number 3 ,retrying in 5 seconds Aug 07 03:34:40 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:34:40 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:34:40 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/music Aug 07 03:34:40 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 07 03:34:40 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 07 03:34:40 volumio---downstairs volumio[1677]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 07 03:34:45 volumio---downstairs sudo[2158]: 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.100.163/jules/albums /mnt/NAS/Albums Aug 07 03:34:45 volumio---downstairs sudo[2158]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:34:50 volumio---downstairs sudo[2090]: pam_unix(sudo:session): session closed for user root Aug 07 03:34:50 volumio---downstairs volumio[1677]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds Aug 07 03:34:50 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:34:50 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:34:50 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/albums Aug 07 03:34:55 volumio---downstairs sudo[2177]: 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.100.163/jules/music /mnt/NAS/Music Aug 07 03:34:55 volumio---downstairs sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:35:00 volumio---downstairs sudo[2158]: pam_unix(sudo:session): session closed for user root Aug 07 03:35:00 volumio---downstairs volumio[1677]: info: Cannot mount NAS Albums at system boot, trial number 4 ,retrying in 5 seconds Aug 07 03:35:00 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:35:00 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:35:00 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/music Aug 07 03:35:05 volumio---downstairs sudo[2200]: 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.100.163/jules/albums /mnt/NAS/Albums Aug 07 03:35:05 volumio---downstairs sudo[2200]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:35:10 volumio---downstairs sudo[2177]: pam_unix(sudo:session): session closed for user root Aug 07 03:35:10 volumio---downstairs volumio[1677]: info: Cannot mount NAS Music at system boot, trial number 4 ,retrying in 5 seconds Aug 07 03:35:10 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:35:10 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:35:10 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/albums Aug 07 03:35:12 volumio---downstairs volumio-time-update[650]: volumio-time-update-util: Date not found in response Aug 07 03:35:12 volumio---downstairs volumio-time-update[650]: volumio-time-update-util: Retrying in 5 seconds... Aug 07 03:35:15 volumio---downstairs sudo[2221]: 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.100.163/jules/music /mnt/NAS/Music Aug 07 03:35:15 volumio---downstairs sudo[2221]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 07 03:35:16 volumio---downstairs volumio[1677]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.832&uuid=7520231d93d5a02356c7607961eaac4e" http://updates.volumio.org/downloader-v1/track-device Aug 07 03:35:16 volumio---downstairs volumio[1677]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 07 03:35:16 volumio---downstairs volumio[1677]: Dload Upload Total Spent Left Speed Aug 07 03:35:16 volumio---downstairs volumio[1677]: [4.3K blob data] Aug 07 03:35:16 volumio---downstairs volumio[1677]: retrying in 5 seconds, trial 0 Aug 07 03:35:16 volumio---downstairs volumio[1677]: info: Volumio Calling Home Aug 07 03:35:17 volumio---downstairs volumio-time-update[650]: volumio-time-update-util: Fetching time from Volumio... Aug 07 03:35:20 volumio---downstairs sudo[2200]: pam_unix(sudo:session): session closed for user root Aug 07 03:35:20 volumio---downstairs volumio[1677]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 07 03:35:20 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:35:20 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:35:20 volumio---downstairs kernel: CIFS: Attempting to mount //192.168.100.163/jules/music Aug 07 03:35:30 volumio---downstairs sudo[2221]: pam_unix(sudo:session): session closed for user root Aug 07 03:35:30 volumio---downstairs volumio[1677]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 07 03:35:30 volumio---downstairs kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 07 03:35:30 volumio---downstairs kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 07 03:35:31 volumio---downstairs volumio[1677]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 07 03:35:31 volumio---downstairs volumio[1677]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com Aug 07 03:35:31 volumio---downstairs volumio[1677]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Aug 07 03:35:31 volumio---downstairs volumio[1677]: errno: -3007, Aug 07 03:35:31 volumio---downstairs volumio[1677]: code: 'ENOTFOUND', Aug 07 03:35:31 volumio---downstairs volumio[1677]: syscall: 'getaddrinfo', Aug 07 03:35:31 volumio---downstairs volumio[1677]: hostname: 'ws.audioscrobbler.com' Aug 07 03:35:31 volumio---downstairs volumio[1677]: } Aug 07 03:35:31 volumio---downstairs volumio[1677]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 07 03:35:31 volumio---downstairs sudo[2272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-07 03:34 Aug 07 03:35:31 volumio---downstairs sudo[2272]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"