-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-04-06 12:39:11 UTC. -- Apr 06 12:38:00 volumio-phong-ngu volumio[1152]: info: MYVOLUMIO Environment detected Apr 06 12:38:00 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:00] [connect] Successful connection Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Plugin folders cleanup Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning into folder /volumio/app/plugins/ Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category audio_interface Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category miscellanea Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category music_service Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category plugins.json Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category system_controller Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category user_interface Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning into folder /data/plugins/ Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Scanning category music_service Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Plugin folders cleanup completed Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: ------------------------------------------- Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: ----- Core plugins startup ---- Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: ------------------------------------------- Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Loading plugins from folder /volumio/app/plugins/ Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Adding plugin upnp to MyMusic Plugins Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Loading plugins from folder /data/plugins/ Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Loading plugin "system"... Apr 06 12:38:01 volumio-phong-ngu volumio[1152]: info: Loading plugin "appearance"... Apr 06 12:38:01 volumio-phong-ngu ntpd[600]: Listen normally on 4 wlan0 192.168.1.199:123 Apr 06 12:38:01 volumio-phong-ngu ntpd[600]: new interface(s) found: waking up resolver Apr 06 12:38:02 volumio-phong-ngu volumio[1152]: info: Loading plugin "network"... Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Refreshing Cached IP Addresses Apr 06 12:38:03 volumio-phong-ngu sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 06 12:38:03 volumio-phong-ngu sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:03 volumio-phong-ngu sudo[1196]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "services"... Apr 06 12:38:03 volumio-phong-ngu sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 06 12:38:03 volumio-phong-ngu sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "alsa_controller"... Apr 06 12:38:03 volumio-phong-ngu sudo[1198]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:03 volumio-phong-ngu sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 06 12:38:03 volumio-phong-ngu sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "wizard"... Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "volumio_command_line_client"... Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "upnp"... Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: [1712407083372] Starting Upmpd Daemon Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "my_music"... Apr 06 12:38:03 volumio-phong-ngu volumio[1152]: info: Loading plugin "mpd"... Apr 06 12:38:04 volumio-phong-ngu volumio[1152]: info: Creating MPD Configuration file Apr 06 12:38:04 volumio-phong-ngu volumio[1152]: info: Loading plugin "upnp_browser"... Apr 06 12:38:04 volumio-phong-ngu sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 06 12:38:04 volumio-phong-ngu sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:04 volumio-phong-ngu sudo[1209]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:04 volumio-phong-ngu sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 06 12:38:04 volumio-phong-ngu sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:04 volumio-phong-ngu systemd[1]: Stopping Music Player Daemon... Apr 06 12:38:04 volumio-phong-ngu systemd[1]: mpd.service: Succeeded. Apr 06 12:38:04 volumio-phong-ngu systemd[1]: Stopped Music Player Daemon. Apr 06 12:38:04 volumio-phong-ngu systemd[1]: Starting Music Player Daemon... Apr 06 12:38:04 volumio-phong-ngu volumio[1152]: info: Loading plugin "networkfs"... Apr 06 12:38:05 volumio-phong-ngu volumio[1152]: info: Starting Udev Watcher for removable devices Apr 06 12:38:05 volumio-phong-ngu sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Hikvision2021,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.200/Disk1share/MUSIC /mnt/NAS/Nas_HIK Apr 06 12:38:05 volumio-phong-ngu sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:05 volumio-phong-ngu kernel: CIFS: Attempting to mount //192.168.1.200/Disk1share/MUSIC Apr 06 12:38:05 volumio-phong-ngu kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Apr 06 12:38:05 volumio-phong-ngu volumio[1152]: info: Ignoring mount for partition: boot Apr 06 12:38:05 volumio-phong-ngu volumio[1152]: info: Ignoring mount for partition: volumio Apr 06 12:38:05 volumio-phong-ngu volumio[1152]: info: Ignoring mount for partition: volumio_data Apr 06 12:38:05 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 06 12:38:05 volumio-phong-ngu volumio[1152]: info: Loading plugin "alarm-clock"... Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Loading plugin "airplay_emulation"... Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Starting Shairport Sync Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Loading plugin "last_100"... Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Loading plugin "webradio"... Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Loading plugin "i2s_dacs"... Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: I2S DAC not set, start Auto-detection Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Loading plugin "volumiodiscovery"... Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:06 volumio-phong-ngu node[1152]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:06 volumio-phong-ngu node[1152]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: *** WARNING *** For more information see Apr 06 12:38:06 volumio-phong-ngu node[1152]: *** WARNING *** For more information see Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:06 volumio-phong-ngu node[1152]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:06 volumio-phong-ngu node[1152]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: *** WARNING *** For more information see Apr 06 12:38:06 volumio-phong-ngu node[1152]: *** WARNING *** For more information see Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Discovery: Started advertising with name: Volumio Phong Ngu Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 06 12:38:06 volumio-phong-ngu volumio[1152]: info: Loading plugin "youtube2"... Apr 06 12:38:06 volumio-phong-ngu mpd[1216]: Apr 06 12:38 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 06 12:38:07 volumio-phong-ngu mpd[1216]: Apr 06 12:38 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 06 12:38:07 volumio-phong-ngu mpd[1216]: Apr 06 12:38 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 06 12:38:07 volumio-phong-ngu systemd[1]: Started Music Player Daemon. Apr 06 12:38:07 volumio-phong-ngu sudo[1211]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:07 volumio-phong-ngu sudo[1201]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:11 volumio-phong-ngu sudo[1219]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:11 volumio-phong-ngu kernel: CIFS VFS: Error connecting to socket. Aborting operation. Apr 06 12:38:11 volumio-phong-ngu kernel: CIFS VFS: cifs_mount failed w/return code = -2 Apr 06 12:38:13 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:13] [connect] Successful connection Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "outputs"... Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "albumart"... Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Plugin example_plugin is not enabled Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "inputs"... Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "updater_comm"... Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Plugin mpdemulation is not enabled Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "rest_api"... Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "websocket"... Apr 06 12:38:14 volumio-phong-ngu volumio[1152]: info: Loading plugin "minidlna"... Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: Applying required configuration parameters for plugin minidlna Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: Loading i18n strings for locale en Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: Updating browse sources language Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: Forking 3 albumart workers Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::initPlayerControls Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: Express server listening on port 3000 Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: [Metrics] WebUI: 16s 803.51ms Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::resetVolumioState Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::getcurrentVolume Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:15 volumio-phong-ngu sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 06 12:38:15 volumio-phong-ngu sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:15 volumio-phong-ngu sudo[1261]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:15 volumio-phong-ngu sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 06 12:38:15 volumio-phong-ngu sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:15 volumio-phong-ngu sudo[1262]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:15 volumio-phong-ngu volumio[1152]: info: Cannot mount NAS Nas_HIK at system boot, trial number 1 ,retrying in 5 seconds Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: MPD Permissions set Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Apr 06 12:38:16 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712407093 101 Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: VolumeController:: Volume=40 Mute =false Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::pushState Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::updateTrackBlock Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CorePlayQueue::getTrackBlock Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: MPD running with PID1216 Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: ,establishing connection Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: info: Reloading queue from file Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: error: updateQueue error: null Apr 06 12:38:16 volumio-phong-ngu volumio[1152]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::setRepeat null single undefined Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::pushState Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::setRandom true Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::pushState Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: info: Setting Device type: Raspberry PI Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: Starting albumart workers Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: Starting albumart workers Apr 06 12:38:17 volumio-phong-ngu volumio[1152]: Starting albumart workers Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: error: updateQueue error: null Apr 06 12:38:18 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=2 locally_generated=1 Apr 06 12:38:18 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:18 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: VolumeController:: Volume=40 Mute =false Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: CoreStateMachine::pushState Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:18 volumio-phong-ngu sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 06 12:38:18 volumio-phong-ngu sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: Completed loading Core Plugins Apr 06 12:38:18 volumio-phong-ngu avahi-daemon[422]: Withdrawing address record for 192.168.1.199 on wlan0. Apr 06 12:38:18 volumio-phong-ngu avahi-daemon[422]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.199. Apr 06 12:38:18 volumio-phong-ngu dhcpcd[696]: wlan0: deleting route to 192.168.1.0/24 Apr 06 12:38:18 volumio-phong-ngu avahi-daemon[422]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 06 12:38:18 volumio-phong-ngu dhcpcd[696]: wlan0: deleting default route via 192.168.1.1 Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: Preparing to generate the ALSA configuration file Apr 06 12:38:18 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:18 volumio-phong-ngu sudo[1280]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: Upmpdcli Daemon Started Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: mDNS: A device disapperared from network Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: Asound.conf file unchanged, so no further update is needed Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: Output device has changed, restarting MPD Apr 06 12:38:18 volumio-phong-ngu sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 06 12:38:18 volumio-phong-ngu sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:18 volumio-phong-ngu sudo[1337]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: Output device has changed, restarting Shairport Sync Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:18 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:18 volumio-phong-ngu sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 06 12:38:18 volumio-phong-ngu sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:19 volumio-phong-ngu systemd[1]: Stopping Music Player Daemon... Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: ___________ START PLUGINS ___________ Apr 06 12:38:19 volumio-phong-ngu systemd[1]: mpd.service: Succeeded. Apr 06 12:38:19 volumio-phong-ngu systemd[1]: Stopped Music Player Daemon. Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: [1712407099082] CoreMusicLibrary::Adding element Media Servers Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:19 volumio-phong-ngu systemd[1]: Starting Music Player Daemon... Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: Cannot find translation for sourceMedia Servers Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: [1712407099390] CoreMusicLibrary::Adding element Last_100 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: Cannot find translation for sourceMedia Servers Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: [1712407099398] CoreMusicLibrary::Adding element Webradio Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: Cannot find translation for sourceMedia Servers Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: [youtube2-auth] Refreshing access token... Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: [1712407099625] CoreMusicLibrary::Adding element YouTube2 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: Cannot find translation for sourceMedia Servers Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: Cannot find translation for sourceYouTube2 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: Loading i18n strings for locale en Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: Volumio Calling Home Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: Unhandled rejection Error: No sockets available, cannot start. Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: error: [youtube2-auth] Failed to refresh access token: Error: getaddrinfo EBUSY www.googleapis.com Apr 06 12:38:19 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: info: [youtube2-auth] Starting auth flow... Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: info: MPD Permissions set Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: ReferenceError: deferred is not defined Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at ClientRequest.emit (events.js:315:20) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at TLSSocket.emit (events.js:315:20) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at emitErrorNT (internal/streams/destroy.js:106:8) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 06 12:38:20 volumio-phong-ngu volumio[1152]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 12:38:20 volumio-phong-ngu ntpd[600]: Deleting interface #4 wlan0, 192.168.1.199#123, interface stats: received=0, sent=0, dropped=0, active_time=19 secs Apr 06 12:38:21 volumio-phong-ngu sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 12:37 Apr 06 12:38:21 volumio-phong-ngu sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:21 volumio-phong-ngu sudo[1368]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:21 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:21 volumio-phong-ngu mpd[1353]: Apr 06 12:38 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 06 12:38:21 volumio-phong-ngu mpd[1353]: Apr 06 12:38 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 06 12:38:21 volumio-phong-ngu mpd[1353]: Apr 06 12:38 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 06 12:38:21 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:21 volumio-phong-ngu systemd[1]: Started Music Player Daemon. Apr 06 12:38:21 volumio-phong-ngu sudo[1340]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:24 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:24 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:24 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:24 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:24 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:24 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:24 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:24 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:25 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:25 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:25 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:25 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:25 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:25 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:25 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:28 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:28] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 06 12:38:28 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:28] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 06 12:38:28 volumio-phong-ngu systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 12:38:28 volumio-phong-ngu systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: Started dynamicswap service. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: dynamicswap.service: Succeeded. Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:28 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:28 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:28 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:28 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:28 volumio-phong-ngu systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: Started dynamicswap service. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: Stopped Volumio Backend Module. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: Started Volumio Backend Module. Apr 06 12:38:28 volumio-phong-ngu systemd[1]: dynamicswap.service: Succeeded. Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:28 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:28 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:28 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:29 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:31 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:32 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:32 volumio-phong-ngu volumio[1483]: info: ----- Volumio3 ---- Apr 06 12:38:32 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:32 volumio-phong-ngu volumio[1483]: info: ----- System startup ---- Apr 06 12:38:32 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:32 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:32 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:33 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:33] [connect] Successful connection Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: MYVOLUMIO Environment detected Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Plugin folders cleanup Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning into folder /volumio/app/plugins/ Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category audio_interface Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category miscellanea Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category music_service Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category plugins.json Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category system_controller Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category user_interface Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning into folder /data/plugins/ Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Scanning category music_service Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Plugin folders cleanup completed Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: ----- Core plugins startup ---- Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Loading plugins from folder /volumio/app/plugins/ Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Adding plugin upnp to MyMusic Plugins Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Loading plugins from folder /data/plugins/ Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Loading plugin "system"... Apr 06 12:38:33 volumio-phong-ngu volumio[1483]: info: Loading plugin "appearance"... Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:35 volumio-phong-ngu volumio[1483]: info: Loading plugin "network"... Apr 06 12:38:35 volumio-phong-ngu volumio[1483]: info: Refreshing Cached IP Addresses Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:35 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:35 volumio-phong-ngu sudo[1598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 06 12:38:35 volumio-phong-ngu sudo[1598]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:35 volumio-phong-ngu sudo[1598]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:35 volumio-phong-ngu sudo[1606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 06 12:38:35 volumio-phong-ngu sudo[1606]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:35 volumio-phong-ngu volumio[1483]: info: Loading plugin "services"... Apr 06 12:38:35 volumio-phong-ngu sudo[1606]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:35 volumio-phong-ngu volumio[1483]: info: Loading plugin "alsa_controller"... Apr 06 12:38:35 volumio-phong-ngu sudo[1614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 06 12:38:35 volumio-phong-ngu sudo[1614]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:35 volumio-phong-ngu sudo[1614]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:35 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Loading plugin "wizard"... Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Loading plugin "volumio_command_line_client"... Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Loading plugin "upnp"... Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: [1712407116072] Starting Upmpd Daemon Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Loading plugin "my_music"... Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Loading plugin "mpd"... Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Creating MPD Configuration file Apr 06 12:38:36 volumio-phong-ngu volumio[1483]: info: Loading plugin "upnp_browser"... Apr 06 12:38:36 volumio-phong-ngu sudo[1630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 06 12:38:36 volumio-phong-ngu sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:36 volumio-phong-ngu sudo[1630]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:36 volumio-phong-ngu sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 06 12:38:36 volumio-phong-ngu sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:36 volumio-phong-ngu systemd[1]: Stopping Music Player Daemon... Apr 06 12:38:36 volumio-phong-ngu systemd[1]: mpd.service: Succeeded. Apr 06 12:38:36 volumio-phong-ngu systemd[1]: Stopped Music Player Daemon. Apr 06 12:38:36 volumio-phong-ngu systemd[1]: Starting Music Player Daemon... Apr 06 12:38:37 volumio-phong-ngu volumio[1483]: info: Loading plugin "networkfs"... Apr 06 12:38:37 volumio-phong-ngu volumio[1483]: info: Starting Udev Watcher for removable devices Apr 06 12:38:37 volumio-phong-ngu sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Hikvision2021,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.200/Disk1share/MUSIC /mnt/NAS/Nas_HIK Apr 06 12:38:37 volumio-phong-ngu sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:37 volumio-phong-ngu kernel: CIFS: Attempting to mount //192.168.1.200/Disk1share/MUSIC Apr 06 12:38:37 volumio-phong-ngu kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Apr 06 12:38:37 volumio-phong-ngu kernel: CIFS VFS: Error connecting to socket. Aborting operation. Apr 06 12:38:37 volumio-phong-ngu kernel: CIFS VFS: cifs_mount failed w/return code = -2 Apr 06 12:38:37 volumio-phong-ngu sudo[1640]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Ignoring mount for partition: boot Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Ignoring mount for partition: volumio Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Ignoring mount for partition: volumio_data Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Loading plugin "alarm-clock"... Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Loading plugin "airplay_emulation"... Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Starting Shairport Sync Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Loading plugin "last_100"... Apr 06 12:38:38 volumio-phong-ngu volumio[1483]: info: Loading plugin "webradio"... Apr 06 12:38:38 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:38 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:38 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:38 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:38 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:38 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:38 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:38 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: Loading plugin "i2s_dacs"... Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: I2S DAC not set, start Auto-detection Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: Loading plugin "volumiodiscovery"... Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: *** WARNING *** For more information see Apr 06 12:38:39 volumio-phong-ngu node[1483]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: *** WARNING *** For more information see Apr 06 12:38:39 volumio-phong-ngu node[1483]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:39 volumio-phong-ngu node[1483]: *** WARNING *** For more information see Apr 06 12:38:39 volumio-phong-ngu node[1483]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 06 12:38:39 volumio-phong-ngu node[1483]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 06 12:38:39 volumio-phong-ngu node[1483]: *** WARNING *** For more information see Apr 06 12:38:39 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 06 12:38:39 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:39 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: Discovery: Started advertising with name: Volumio Phong Ngu Apr 06 12:38:39 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:39 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 06 12:38:39 volumio-phong-ngu volumio[1483]: info: Loading plugin "youtube2"... Apr 06 12:38:39 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:39 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:39 volumio-phong-ngu mpd[1637]: Apr 06 12:38 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 06 12:38:39 volumio-phong-ngu mpd[1637]: Apr 06 12:38 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 06 12:38:39 volumio-phong-ngu mpd[1637]: Apr 06 12:38 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 06 12:38:39 volumio-phong-ngu systemd[1]: Started Music Player Daemon. Apr 06 12:38:39 volumio-phong-ngu sudo[1632]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:42 volumio-phong-ngu nmbd[567]: [2024/04/06 12:38:42.454486, 0] ../source3/libsmb/nmblib.c:917(send_udp) Apr 06 12:38:42 volumio-phong-ngu nmbd[567]: Packet send failed to 192.168.1.255(138) ERRNO=Network is unreachable Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:42 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:42 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:44 volumio-phong-ngu ntpd[600]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-DISCONNECTED bssid=26:43:e2:d5:6b:c0 reason=7 locally_generated=1 Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:45 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:38:45] [connect] Successful connection Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:45 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:45 volumio-phong-ngu wpa_supplicant[682]: wlan0: Trying to associate with SSID 'NewTech' Apr 06 12:38:46 volumio-phong-ngu ntpd[600]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "outputs"... Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "albumart"... Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Plugin example_plugin is not enabled Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "inputs"... Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "updater_comm"... Apr 06 12:38:47 volumio-phong-ngu ntpd[600]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Plugin mpdemulation is not enabled Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "rest_api"... Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "websocket"... Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Loading plugin "minidlna"... Apr 06 12:38:47 volumio-phong-ngu volumio[1483]: info: Applying required configuration parameters for plugin minidlna Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: Loading i18n strings for locale en Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: Updating browse sources language Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::initPlayerControls Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: Forking 3 albumart workers Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: Express server listening on port 3000 Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: [Metrics] WebUI: 17s 32.78ms Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::resetVolumioState Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::getcurrentVolume Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:48 volumio-phong-ngu sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 06 12:38:48 volumio-phong-ngu sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:48 volumio-phong-ngu sudo[1809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 06 12:38:48 volumio-phong-ngu sudo[1809]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:48 volumio-phong-ngu sudo[1807]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:48 volumio-phong-ngu sudo[1809]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: Cannot mount NAS Nas_HIK at system boot, trial number 1 ,retrying in 5 seconds Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: MPD Permissions set Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: wlan0 Interface doesn't support scanning : Device or resource busy Apr 06 12:38:48 volumio-phong-ngu volumio[1483]: info: Cannot use regular scanning, forcing with ap-force Apr 06 12:38:48 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:48 volumio-phong-ngu wpa_supplicant[682]: wlan0: Associated with 26:43:e2:d5:6b:c0 Apr 06 12:38:48 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-CONNECTED - Connection to 26:43:e2:d5:6b:c0 completed [id=1 id_str=] Apr 06 12:38:48 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 06 12:38:48 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:48 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:48 volumio-phong-ngu dhcpcd[696]: wlan0: carrier lost Apr 06 12:38:48 volumio-phong-ngu sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 06 12:38:48 volumio-phong-ngu sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:48 volumio-phong-ngu wpa_supplicant[682]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=VN Apr 06 12:38:49 volumio-phong-ngu dhcpcd[696]: wlan0: carrier acquired Apr 06 12:38:49 volumio-phong-ngu dhcpcd[696]: wlan0: IAID eb:2b:b8:87 Apr 06 12:38:49 volumio-phong-ngu dhcpcd[696]: wlan0: probing address 192.168.1.199/24 Apr 06 12:38:49 volumio-phong-ngu ntpd[600]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 06 12:38:49 volumio-phong-ngu dhcpcd[696]: wlan0: soliciting an IPv6 router Apr 06 12:38:49 volumio-phong-ngu volumio[1483]: Starting albumart workers Apr 06 12:38:49 volumio-phong-ngu volumio[1483]: Starting albumart workers Apr 06 12:38:49 volumio-phong-ngu volumio[1483]: Starting albumart workers Apr 06 12:38:53 volumio-phong-ngu sudo[1816]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: MPD running with PID1637 Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: ,establishing connection Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: VolumeController:: Volume=40 Mute =false Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::pushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::updateTrackBlock Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CorePlayQueue::getTrackBlock Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: error: MPD error: The expression evaluated to a falsy value: Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: assert.ok(self.idling) Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: error: MPD error: The expression evaluated to a falsy value: Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: assert.ok(self.idling) Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: Reloading queue from file Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::setRepeat null single undefined Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::pushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::setRandom true Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::pushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: Setting Device type: Raspberry PI Apr 06 12:38:53 volumio-phong-ngu sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Hikvision2021,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.200/Disk1share/MUSIC /mnt/NAS/Nas_HIK Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: error: updateQueue error: null Apr 06 12:38:53 volumio-phong-ngu sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: VolumeController:: Volume=40 Mute =false Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreStateMachine::pushState Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CorePlayQueue::getTrack 0 Apr 06 12:38:53 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioPushState Apr 06 12:38:53 volumio-phong-ngu kernel: CIFS: Attempting to mount //192.168.1.200/Disk1share/MUSIC Apr 06 12:38:53 volumio-phong-ngu kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Apr 06 12:38:53 volumio-phong-ngu kernel: CIFS VFS: Error connecting to socket. Aborting operation. Apr 06 12:38:53 volumio-phong-ngu kernel: CIFS VFS: cifs_mount failed w/return code = -2 Apr 06 12:38:53 volumio-phong-ngu sudo[1875]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Completed loading Core Plugins Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Preparing to generate the ALSA configuration file Apr 06 12:38:54 volumio-phong-ngu sudo[1880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 06 12:38:54 volumio-phong-ngu sudo[1880]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Cannot mount NAS Nas_HIK at system boot, trial number 2 ,retrying in 5 seconds Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Asound.conf file unchanged, so no further update is needed Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Output device has changed, restarting MPD Apr 06 12:38:54 volumio-phong-ngu sudo[1880]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:54 volumio-phong-ngu sudo[1883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 06 12:38:54 volumio-phong-ngu sudo[1883]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Output device has changed, restarting Shairport Sync Apr 06 12:38:54 volumio-phong-ngu sudo[1883]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:54 volumio-phong-ngu sudo[1886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 06 12:38:54 volumio-phong-ngu sudo[1886]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:54 volumio-phong-ngu dhcpcd[696]: wlan0: using static address 192.168.1.199/24 Apr 06 12:38:54 volumio-phong-ngu avahi-daemon[422]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.199. Apr 06 12:38:54 volumio-phong-ngu systemd[1]: Stopping Music Player Daemon... Apr 06 12:38:54 volumio-phong-ngu avahi-daemon[422]: New relevant interface wlan0.IPv4 for mDNS. Apr 06 12:38:54 volumio-phong-ngu dhcpcd[696]: wlan0: adding route to 192.168.1.0/24 Apr 06 12:38:54 volumio-phong-ngu avahi-daemon[422]: Registering new address record for 192.168.1.199 on wlan0.IPv4. Apr 06 12:38:54 volumio-phong-ngu dhcpcd[696]: wlan0: adding default route via 192.168.1.1 Apr 06 12:38:54 volumio-phong-ngu systemd[1]: mpd.service: Succeeded. Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 06 12:38:54 volumio-phong-ngu systemd[1]: Stopped Music Player Daemon. Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: ___________ START PLUGINS ___________ Apr 06 12:38:54 volumio-phong-ngu systemd[1]: Starting Music Player Daemon... Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: [1712407134245] CoreMusicLibrary::Adding element Media Servers Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: Cannot find translation for sourceMedia Servers Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: [1712407134562] CoreMusicLibrary::Adding element Last_100 Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: Cannot find translation for sourceMedia Servers Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: [1712407134570] CoreMusicLibrary::Adding element Webradio Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: Cannot find translation for sourceMedia Servers Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: [youtube2-auth] Refreshing access token... Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: [1712407134767] CoreMusicLibrary::Adding element YouTube2 Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: Cannot find translation for sourceMedia Servers Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: Cannot find translation for sourceYouTube2 Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Loading i18n strings for locale en Apr 06 12:38:54 volumio-phong-ngu volumio[1483]: info: Volumio Calling Home Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: MPD Permissions set Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Upmpdcli Daemon Started Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 12:38:55 volumio-phong-ngu ntpd[600]: Listen normally on 5 wlan0 192.168.1.199:123 Apr 06 12:38:55 volumio-phong-ngu ntpd[600]: new interface(s) found: waking up resolver Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: minidlna: Found miniDLNA version 1.2.1 Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: minidlna: Starting minidlna.service Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Starting Shairport Sync Apr 06 12:38:55 volumio-phong-ngu sudo[1932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Apr 06 12:38:55 volumio-phong-ngu sudo[1932]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Starting Shairport Sync Apr 06 12:38:55 volumio-phong-ngu sudo[1934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 06 12:38:55 volumio-phong-ngu sudo[1934]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:55 volumio-phong-ngu sudo[1932]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Starting Shairport Sync Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 06 12:38:55 volumio-phong-ngu systemd[1]: shairport-sync.service: Succeeded. Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 06 12:38:55 volumio-phong-ngu sudo[1938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 06 12:38:55 volumio-phong-ngu sudo[1938]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:55 volumio-phong-ngu sudo[1934]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Shairport-Sync Started Apr 06 12:38:55 volumio-phong-ngu sudo[1942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 06 12:38:55 volumio-phong-ngu sudo[1942]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: Error adding Membership: Error: addMembership EINVAL Apr 06 12:38:55 volumio-phong-ngu systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 06 12:38:55 volumio-phong-ngu systemd[1]: shairport-sync.service: Succeeded. Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: minidlna: systemctl start minidlna.service succeeded. Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Completed starting Core Plugins Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: ----- MyVolumio plugins startup ---- Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: ------------------------------------------- Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 06 12:38:55 volumio-phong-ngu sudo[1938]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Shairport-Sync Started Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 06 12:38:55 volumio-phong-ngu systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 06 12:38:55 volumio-phong-ngu systemd[1]: shairport-sync.service: Succeeded. Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 06 12:38:55 volumio-phong-ngu systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 06 12:38:55 volumio-phong-ngu sudo[1942]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:55 volumio-phong-ngu volumio[1483]: info: Shairport-Sync Started Apr 06 12:38:56 volumio-phong-ngu mpd[1920]: Apr 06 12:38 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 06 12:38:57 volumio-phong-ngu mpd[1920]: Apr 06 12:38 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 06 12:38:57 volumio-phong-ngu mpd[1920]: Apr 06 12:38 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 06 12:38:57 volumio-phong-ngu systemd[1]: Started Music Player Daemon. Apr 06 12:38:57 volumio-phong-ngu sudo[1886]: pam_unix(sudo:session): session closed for user root Apr 06 12:38:57 volumio-phong-ngu volumio[1483]: error: updateQueue error: null Apr 06 12:38:58 volumio-phong-ngu volumio[1483]: error: MPD error: The expression evaluated to a falsy value: Apr 06 12:38:58 volumio-phong-ngu volumio[1483]: assert.ok(self.idling) Apr 06 12:38:58 volumio-phong-ngu volumio[1483]: error: updateQueue error: null Apr 06 12:38:59 volumio-phong-ngu sudo[1951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Hikvision2021,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.200/Disk1share/MUSIC /mnt/NAS/Nas_HIK Apr 06 12:38:59 volumio-phong-ngu sudo[1951]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 12:38:59 volumio-phong-ngu kernel: CIFS: Attempting to mount //192.168.1.200/Disk1share/MUSIC Apr 06 12:38:59 volumio-phong-ngu kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Apr 06 12:39:00 volumio-phong-ngu volumio[1483]: error: [youtube2-auth] Failed to refresh access token: Error: certificate is not yet valid Apr 06 12:39:00 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 12:39:00 volumio-phong-ngu volumio[1483]: info: [youtube2-auth] Starting auth flow... Apr 06 12:39:00 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 12:39:00 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:39:00] [connect] Successful connection Apr 06 12:39:00 volumio-phong-ngu volumio-remote-updater[411]: [2024-04-06 12:39:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712407140 101 Apr 06 12:39:00 volumio-phong-ngu volumio[1483]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 Apr 06 12:39:00 volumio-phong-ngu volumio[1483]: info: Volumio called home Apr 06 12:39:03 volumio-phong-ngu volumio[1483]: error: updateQueue error: null Apr 06 12:39:05 volumio-phong-ngu sudo[1951]: pam_unix(sudo:session): session closed for user root Apr 06 12:39:05 volumio-phong-ngu kernel: CIFS VFS: Error connecting to socket. Aborting operation. Apr 06 12:39:05 volumio-phong-ngu kernel: CIFS VFS: cifs_mount failed w/return code = -2 Apr 06 12:39:05 volumio-phong-ngu volumio[1483]: info: Cannot mount NAS Nas_HIK at system boot, trial number 3 ,retrying in 5 seconds Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: info: CoreCommandRouter::volumioGetState Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: info: CorePlayQueue::getTrack 0 Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: ReferenceError: deferred is not defined Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at ClientRequest.emit (events.js:315:20) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at TLSSocket.emit (events.js:315:20) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at emitErrorNT (internal/streams/destroy.js:106:8) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 06 12:39:10 volumio-phong-ngu volumio[1483]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 12:39:11 volumio-phong-ngu sudo[1964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 12:38 Apr 06 12:39:11 volumio-phong-ngu sudo[1964]: 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="682e0b17433cee9f9da31457f545345105e06e63" VOLUMIO_FE_VERSION="fba46add594d630e1b506bc42f1beddaad53fb64" VOLUMIO_FE3_VERSION="c23fef6dba8e02db978bd39bd8d26872e60ada6e" VOLUMIO_BE_VERSION="f7885966dee9f148ddf4f5050103a7d6734e1a10" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 20 Dec 2021 04:57:50 PM CET" VOLUMIO_VERSION="3.179" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6d5d4c489f0b1e608d9cefb791a9102d"