-- Logs begin at Mon 2024-04-22 19:32:52 UTC, end at Mon 2024-04-22 20:35:32 UTC. -- Apr 22 20:34:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 22 20:34:03 volumio volumio-remote-updater[547]: [2024-04-22 20:34:03] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Apr 22 20:34:03 volumio volumio-remote-updater[547]: [2024-04-22 20:34:03] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Apr 22 20:34:03 volumio volumio-remote-updater[547]: [2024-04-22 20:34:03] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Apr 22 20:34:03 volumio ntfs-3g[1156]: Unmounting /dev/sdb1 (Музыка 500г 2) Apr 22 20:34:03 volumio systemd[1]: media-\xd0\x9c\xd1\x83\xd0\xb7\xd1\x8b\xd0\xba\xd0\xb0_500\xd0\xb3_2.mount: Succeeded. Apr 22 20:34:03 volumio systemd[1]: media-\xd0\x9c\xd1\x83\xd0\xb7\xd1\x8b\xd0\xba\xd0\xb0_500\xd0\xb3.mount: Succeeded. Apr 22 20:34:03 volumio ntfs-3g[1145]: Unmounting /dev/sda1 (Музыка 500г) Apr 22 20:34:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 22 20:34:03 volumio systemd[1]: Started dynamicswap service. Apr 22 20:34:03 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 22 20:34:03 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 20:34:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Apr 22 20:34:03 volumio systemd[1]: Stopped Volumio Backend Module. Apr 22 20:34:03 volumio systemd[1]: Started Volumio Backend Module. Apr 22 20:34:03 volumio systemd[1]: Started dynamicswap service. Apr 22 20:34:04 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 22 20:34:04 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:04 volumio volumio[12117]: info: ----- Volumio3 ---- Apr 22 20:34:04 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:04 volumio volumio[12117]: info: ----- System startup ---- Apr 22 20:34:04 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:04 volumio volumio[12117]: info: MYVOLUMIO Environment detected Apr 22 20:34:04 volumio volumio[12117]: info: Plugin folders cleanup Apr 22 20:34:04 volumio volumio[12117]: info: Scanning into folder /volumio/app/plugins/ Apr 22 20:34:04 volumio volumio[12117]: info: Scanning category audio_interface Apr 22 20:34:04 volumio volumio[12117]: info: Scanning category miscellanea Apr 22 20:34:04 volumio volumio[12117]: info: Scanning category music_service Apr 22 20:34:04 volumio volumio[12117]: info: Scanning category plugins.json Apr 22 20:34:04 volumio volumio[12117]: info: Scanning category system_controller Apr 22 20:34:04 volumio volumio[12117]: info: Scanning category user_interface Apr 22 20:34:04 volumio volumio[12117]: info: Scanning into folder /data/plugins/ Apr 22 20:34:04 volumio volumio[12117]: info: Plugin folders cleanup completed Apr 22 20:34:04 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:04 volumio volumio[12117]: info: ----- Core plugins startup ---- Apr 22 20:34:04 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:04 volumio volumio[12117]: info: Loading plugins from folder /volumio/app/plugins/ Apr 22 20:34:04 volumio volumio[12117]: info: Adding plugin upnp to MyMusic Plugins Apr 22 20:34:04 volumio volumio[12117]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 22 20:34:04 volumio volumio[12117]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 22 20:34:04 volumio volumio[12117]: info: Loading plugins from folder /data/plugins/ Apr 22 20:34:04 volumio volumio[12117]: info: Loading plugin "system"... Apr 22 20:34:05 volumio volumio[12117]: info: Loading plugin "appearance"... Apr 22 20:34:05 volumio volumio[12117]: info: Loading plugin "network"... Apr 22 20:34:05 volumio volumio[12117]: info: Refreshing Cached IP Addresses Apr 22 20:34:05 volumio sudo[12145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 20:34:05 volumio sudo[12145]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:05 volumio sudo[12145]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:05 volumio sudo[12147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 20:34:05 volumio sudo[12147]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:05 volumio volumio[12117]: info: Loading plugin "services"... Apr 22 20:34:05 volumio sudo[12147]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:05 volumio volumio[12117]: info: Loading plugin "alsa_controller"... Apr 22 20:34:05 volumio sudo[12150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 22 20:34:05 volumio sudo[12150]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:05 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 20:34:05 volumio volumio[12117]: info: Loading plugin "wizard"... Apr 22 20:34:05 volumio volumio[12117]: info: Loading plugin "networkfs"... Apr 22 20:34:05 volumio volumio[12117]: info: Starting Udev Watcher for removable devices Apr 22 20:34:05 volumio sudo[12156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:34:05 volumio sudo[12156]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:05 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:34:05 volumio volumio[12117]: info: Mounting Device Музыка_500г Apr 22 20:34:05 volumio sudo[12164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Музыка_500г -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:34:05 volumio sudo[12164]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:06 volumio sudo[12164]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:06 volumio ntfs-3g[12168]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 22 20:34:06 volumio ntfs-3g[12168]: Mounted /dev/sda1 (Read-Write, label "Музыка 500г", NTFS 3.1) Apr 22 20:34:06 volumio ntfs-3g[12168]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:34:06 volumio ntfs-3g[12168]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Apr 22 20:34:06 volumio ntfs-3g[12168]: Global ownership and permissions enforced, configuration type 7 Apr 22 20:34:06 volumio volumio[12117]: info: Mounting Device Музыка_500г_2 Apr 22 20:34:06 volumio sudo[12173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Музыка_500г_2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:34:06 volumio sudo[12173]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:06 volumio sudo[12156]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:06 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:34:06 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:34:06 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:34:06 volumio ntfs-3g[12176]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 22 20:34:06 volumio ntfs-3g[12176]: Mounted /dev/sdb1 (Read-Write, label "Музыка 500г 2", NTFS 3.1) Apr 22 20:34:06 volumio ntfs-3g[12176]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:34:06 volumio ntfs-3g[12176]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Apr 22 20:34:06 volumio ntfs-3g[12176]: Global ownership and permissions enforced, configuration type 7 Apr 22 20:34:06 volumio ntfs-3g[12176]: Unmounting /dev/sdb1 (Музыка 500г 2) Apr 22 20:34:06 volumio sudo[12173]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:06 volumio volumio[12117]: info: Ignoring mount for partition: boot Apr 22 20:34:06 volumio volumio[12117]: info: Ignoring mount for partition: volumio Apr 22 20:34:06 volumio volumio[12117]: info: Ignoring mount for partition: volumio_data Apr 22 20:34:06 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 20:34:06 volumio volumio[12117]: info: Loading plugin "volumio_command_line_client"... Apr 22 20:34:06 volumio volumio[12117]: info: Loading plugin "upnp"... Apr 22 20:34:06 volumio volumio[12117]: info: [1713818046724] Starting Upmpd Daemon Apr 22 20:34:06 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 20:34:06 volumio volumio[12117]: info: Loading plugin "my_music"... Apr 22 20:34:06 volumio volumio[12117]: info: Loading plugin "mpd"... Apr 22 20:34:06 volumio volumio[12117]: info: Loading plugin "upnp_browser"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "alarm-clock"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "airplay_emulation"... Apr 22 20:34:07 volumio volumio[12117]: info: Starting Shairport Sync Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "last_100"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "webradio"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "i2s_dacs"... Apr 22 20:34:07 volumio volumio[12117]: info: I2S DAC not set, start Auto-detection Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "volumiodiscovery"... Apr 22 20:34:07 volumio volumio[12117]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 20:34:07 volumio volumio[12117]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:34:07 volumio node[12117]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 20:34:07 volumio volumio[12117]: *** WARNING *** For more information see Apr 22 20:34:07 volumio volumio[12117]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 20:34:07 volumio volumio[12117]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:34:07 volumio volumio[12117]: *** WARNING *** For more information see Apr 22 20:34:07 volumio node[12117]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:34:07 volumio node[12117]: *** WARNING *** For more information see Apr 22 20:34:07 volumio node[12117]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 20:34:07 volumio node[12117]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:34:07 volumio node[12117]: *** WARNING *** For more information see Apr 22 20:34:07 volumio volumio[12117]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 22 20:34:07 volumio volumio[12117]: info: Discovery: Started advertising with name: Volumio Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "outputs"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "albumart"... Apr 22 20:34:07 volumio volumio[12117]: info: Plugin example_plugin is not enabled Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "inputs"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "updater_comm"... Apr 22 20:34:07 volumio volumio[12117]: info: Plugin mpdemulation is not enabled Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "rest_api"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading plugin "websocket"... Apr 22 20:34:07 volumio volumio[12117]: info: Loading i18n strings for locale ru Apr 22 20:34:07 volumio volumio[12117]: Updating browse sources language Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:34:07 volumio volumio[12117]: Forking 1 albumart workers Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::initPlayerControls Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: Express server listening on port 3000 Apr 22 20:34:07 volumio volumio[12117]: [Metrics] WebUI: 3s 49.46ms Apr 22 20:34:07 volumio volumio[12117]: info: Setting Device type: x86 Apr 22 20:34:07 volumio volumio[12117]: info: CoreStateMachine::resetVolumioState Apr 22 20:34:07 volumio volumio[12117]: info: CoreStateMachine::getcurrentVolume Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 20:34:07 volumio volumio[12117]: info: CoreStateMachine::pushState Apr 22 20:34:07 volumio volumio[12117]: info: CorePlayQueue::getTrack 0 Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::volumioPushState Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 22 20:34:07 volumio volumio[12117]: info: Completed loading Core Plugins Apr 22 20:34:07 volumio volumio[12117]: info: Preparing to generate the ALSA configuration file Apr 22 20:34:07 volumio volumio[12117]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Apr 22 20:34:07 volumio volumio[12117]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 22 20:34:07 volumio volumio[12117]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 1 Apr 22 20:34:07 volumio volumio[12117]: info: Reloading queue from file Apr 22 20:34:07 volumio volumio[12117]: info: Asound.conf file unchanged, so no further update is needed Apr 22 20:34:07 volumio volumio[12117]: info: Output device has changed, restarting MPD Apr 22 20:34:07 volumio sudo[12198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 20:34:07 volumio volumio[12117]: info: Output device has changed, restarting Shairport Sync Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio sudo[12198]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:07 volumio sudo[12198]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:07 volumio sudo[12201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 20:34:07 volumio sudo[12201]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:07 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 20:34:07 volumio volumio[12117]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 20:34:07 volumio volumio[12117]: info: ___________ START PLUGINS ___________ Apr 22 20:34:07 volumio volumio[12117]: info: ControllerMpd::onStart: Initializing MPD Apr 22 20:34:07 volumio volumio[12117]: info: Creating MPD Configuration file Apr 22 20:34:07 volumio sudo[12207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 20:34:07 volumio sudo[12207]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 20:34:07 volumio sudo[12207]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 20:34:07 volumio volumio[12117]: info: [1713818047794] CoreMusicLibrary::Adding element Медиа-серверы Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:07 volumio sudo[12210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 20:34:07 volumio systemd[1]: mpd.service: Succeeded. Apr 22 20:34:07 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 20:34:07 volumio sudo[12210]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:07 volumio systemd[1]: Starting Music Player Daemon... Apr 22 20:34:07 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 22 20:34:07 volumio systemd[1]: mpd.service: Succeeded. Apr 22 20:34:07 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 20:34:07 volumio volumio[12117]: Starting albumart workers Apr 22 20:34:07 volumio systemd[1]: Starting Music Player Daemon... Apr 22 20:34:07 volumio volumio[12117]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:07 volumio volumio[12117]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 20:34:07 volumio volumio[12117]: info: [1713818047949] CoreMusicLibrary::Adding element Last_100 Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 20:34:07 volumio volumio[12117]: info: [1713818047961] CoreMusicLibrary::Adding element Webradio Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:34:07 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 20:34:07 volumio volumio[12117]: info: Volumio Calling Home Apr 22 20:34:08 volumio volumio[12117]: info: CoreStateMachine::setRepeat true single undefined Apr 22 20:34:08 volumio volumio[12117]: info: CoreStateMachine::pushState Apr 22 20:34:08 volumio volumio[12117]: info: CorePlayQueue::getTrack 0 Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::volumioPushState Apr 22 20:34:08 volumio volumio[12117]: info: CoreStateMachine::setRandom false Apr 22 20:34:08 volumio volumio[12117]: info: CoreStateMachine::pushState Apr 22 20:34:08 volumio volumio[12117]: info: CorePlayQueue::getTrack 0 Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::volumioPushState Apr 22 20:34:08 volumio volumio[12117]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 2 Apr 22 20:34:08 volumio volumio[12117]: info: MPD Permissions set Apr 22 20:34:08 volumio volumio[12117]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 22 20:34:08 volumio mpd[12217]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 20:34:08 volumio mpd[12217]: output: No 'audio_output' defined in config file Apr 22 20:34:08 volumio mpd[12217]: output: Successfully detected a sndio audio device Apr 22 20:34:08 volumio mpd[12217]: zeroconf: No global port, disabling zeroconf Apr 22 20:34:08 volumio systemd[1]: Started Music Player Daemon. Apr 22 20:34:08 volumio sudo[12210]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:08 volumio sudo[12201]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:08 volumio volumio[12117]: info: Completed starting Core Plugins Apr 22 20:34:08 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:08 volumio volumio[12117]: info: ----- MyVolumio plugins startup ---- Apr 22 20:34:08 volumio volumio[12117]: info: ------------------------------------------- Apr 22 20:34:08 volumio volumio[12117]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::volumioGetState Apr 22 20:34:08 volumio volumio[12117]: info: CorePlayQueue::getTrack 0 Apr 22 20:34:08 volumio volumio[12117]: info: MPD running with PID12217 Apr 22 20:34:08 volumio volumio[12117]: ,establishing connection Apr 22 20:34:08 volumio volumio[12117]: info: Starting Shairport Sync Apr 22 20:34:08 volumio volumio[12117]: info: Starting Shairport Sync Apr 22 20:34:08 volumio sudo[12250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 20:34:08 volumio sudo[12250]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 20:34:08 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 20:34:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 20:34:08 volumio volumio[12117]: info: Starting Shairport Sync Apr 22 20:34:08 volumio sudo[12253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 20:34:08 volumio sudo[12253]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 20:34:08 volumio sudo[12250]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 20:34:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 22 20:34:08 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 20:34:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 20:34:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 20:34:08 volumio sudo[12253]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:08 volumio sudo[12257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 20:34:08 volumio sudo[12257]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 20:34:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 20:34:08 volumio volumio[12117]: info: Listing playlists Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::volumioGetQueue Apr 22 20:34:08 volumio volumio[12117]: info: CoreStateMachine::getQueue Apr 22 20:34:08 volumio volumio[12117]: info: CorePlayQueue::getQueue Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 20:34:08 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:34:08 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 20:34:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 20:34:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 20:34:08 volumio sudo[12257]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:08 volumio volumio-remote-updater[547]: [2024-04-22 20:34:08] [connect] Successful connection Apr 22 20:34:08 volumio volumio[12117]: error: MPD error: The expression evaluated to a falsy value: Apr 22 20:34:08 volumio volumio[12117]: assert.ok(self.idling) Apr 22 20:34:08 volumio volumio[12117]: error: The expression evaluated to a falsy value: Apr 22 20:34:08 volumio volumio[12117]: assert.ok(self.idling) Apr 22 20:34:08 volumio volumio[12117]: error: MPD error: The expression evaluated to a falsy value: Apr 22 20:34:08 volumio volumio[12117]: assert.ok(self.idling) Apr 22 20:34:08 volumio volumio[12117]: error: The expression evaluated to a falsy value: Apr 22 20:34:08 volumio volumio[12117]: assert.ok(self.idling) Apr 22 20:34:08 volumio volumio[12117]: info: Shairport-Sync Started Apr 22 20:34:08 volumio volumio[12117]: Error adding Membership: Error: addMembership EINVAL Apr 22 20:34:08 volumio volumio[12117]: info: Shairport-Sync Started Apr 22 20:34:08 volumio volumio[12117]: info: Shairport-Sync Started Apr 22 20:34:08 volumio volumio[12117]: error: updateQueue error: null Apr 22 20:34:08 volumio volumio-remote-updater[547]: [2024-04-22 20:34:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713818048 101 Apr 22 20:34:08 volumio volumio[12117]: 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 22 20:34:09 volumio sudo[12150]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:12 volumio sudo[12265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:34:12 volumio sudo[12265]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:12 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:34:12 volumio sudo[12265]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:12 volumio volumio[12117]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Apr 22 20:34:12 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:34:12 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:34:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:34:13 volumio mpd[12217]: exception: No database Apr 22 20:34:13 volumio mpd[12217]: exception: No database Apr 22 20:34:13 volumio volumio[12117]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Apr 22 20:34:16 volumio sudo[12271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 20:34:16 volumio sudo[12271]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:16 volumio sudo[12271]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:16 volumio sudo[12274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 20:34:16 volumio sudo[12274]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:16 volumio sudo[12274]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:16 volumio sudo[12277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 22 20:34:16 volumio sudo[12277]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:16 volumio sudo[12277]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:16 volumio volumio[12117]: info: Upmpdcli Daemon Started Apr 22 20:34:17 volumio sudo[12280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:34:17 volumio sudo[12280]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:17 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:34:18 volumio sudo[12280]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:18 volumio volumio[12117]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Apr 22 20:34:18 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:34:18 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:34:18 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:34:23 volumio sudo[12287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:34:23 volumio sudo[12287]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:23 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:34:23 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:34:23 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:34:23 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:34:23 volumio sudo[12287]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:23 volumio volumio[12117]: info: Cannot mount NAS music at system boot, trial number 4 ,retrying in 5 seconds Apr 22 20:34:25 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 22 20:34:25 volumio volumio[12117]: info: Preload queue cleared Apr 22 20:34:26 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 22 20:34:26 volumio volumio[12117]: info: Preload queue cleared Apr 22 20:34:27 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 22 20:34:28 volumio volumio[12117]: info: Preload queue cleared Apr 22 20:34:28 volumio volumio[12117]: error: MyVolumio Plugin failed to start in a timely fashion Apr 22 20:34:28 volumio volumio[12117]: info: BOOT COMPLETED Apr 22 20:34:28 volumio volumio[12117]: [Metrics] CommandRouter: 23s 903.06ms Apr 22 20:34:28 volumio volumio[12117]: info: CoreCommandRouter::volumiosetStartupVolume Apr 22 20:34:28 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:34:28 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:34:28 volumio volumio[12117]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:34:28 volumio volumio[12117]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:34:28 volumio sudo[12295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:34:28 volumio sudo[12295]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:28 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:34:28 volumio sudo[12295]: pam_unix(sudo:session): session closed for user root Apr 22 20:34:28 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:34:28 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:34:28 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:34:28 volumio volumio[12117]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 22 20:34:29 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 22 20:34:29 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 22 20:34:29 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 22 20:34:32 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 22 20:34:33 volumio volumio[12117]: info: Preload queue cleared Apr 22 20:34:35 volumio volumio[12117]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 22 20:34:35 volumio volumio[12117]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 20:34:35 volumio volumio[12117]: TypeError: Cannot read property 'length' of undefined Apr 22 20:34:35 volumio volumio[12117]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 22 20:34:35 volumio volumio[12117]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 22 20:34:35 volumio volumio[12117]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 22 20:34:35 volumio volumio[12117]: at Parser.emit (events.js:400:28) Apr 22 20:34:35 volumio volumio[12117]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 22 20:34:35 volumio volumio[12117]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 22 20:34:35 volumio volumio[12117]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 22 20:34:35 volumio volumio[12117]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 22 20:34:35 volumio volumio[12117]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 22 20:34:35 volumio volumio[12117]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 22 20:34:35 volumio volumio[12117]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 22 20:34:35 volumio volumio[12117]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 22 20:34:35 volumio volumio[12117]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 22 20:34:35 volumio volumio[12117]: at IncomingMessage.emit (events.js:412:35) Apr 22 20:34:35 volumio volumio[12117]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 22 20:34:35 volumio volumio[12117]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 22 20:34:35 volumio volumio[12117]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 20:34:35 volumio sudo[12311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 20:33 Apr 22 20:34:35 volumio sudo[12311]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:34:35 volumio sudo[12311]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:04 volumio volumio-remote-updater[547]: [2024-04-22 20:35:04] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Apr 22 20:35:04 volumio volumio-remote-updater[547]: [2024-04-22 20:35:04] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Apr 22 20:35:04 volumio volumio-remote-updater[547]: [2024-04-22 20:35:04] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Apr 22 20:35:04 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 22 20:35:04 volumio ntfs-3g[12168]: Unmounting /dev/sda1 (Музыка 500г) Apr 22 20:35:04 volumio systemd[1]: media-\xd0\x9c\xd1\x83\xd0\xb7\xd1\x8b\xd0\xba\xd0\xb0_500\xd0\xb3.mount: Succeeded. Apr 22 20:35:04 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 22 20:35:04 volumio systemd[1]: Started dynamicswap service. Apr 22 20:35:04 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 22 20:35:04 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 20:35:04 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Apr 22 20:35:04 volumio systemd[1]: Started dynamicswap service. Apr 22 20:35:04 volumio systemd[1]: Stopped Volumio Backend Module. Apr 22 20:35:04 volumio systemd[1]: Started Volumio Backend Module. Apr 22 20:35:04 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 22 20:35:05 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:05 volumio volumio[12383]: info: ----- Volumio3 ---- Apr 22 20:35:05 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:05 volumio volumio[12383]: info: ----- System startup ---- Apr 22 20:35:05 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:05 volumio volumio[12383]: info: MYVOLUMIO Environment detected Apr 22 20:35:05 volumio volumio[12383]: info: Plugin folders cleanup Apr 22 20:35:05 volumio volumio[12383]: info: Scanning into folder /volumio/app/plugins/ Apr 22 20:35:05 volumio volumio[12383]: info: Scanning category audio_interface Apr 22 20:35:05 volumio volumio[12383]: info: Scanning category miscellanea Apr 22 20:35:05 volumio volumio[12383]: info: Scanning category music_service Apr 22 20:35:05 volumio volumio[12383]: info: Scanning category plugins.json Apr 22 20:35:05 volumio volumio[12383]: info: Scanning category system_controller Apr 22 20:35:05 volumio volumio[12383]: info: Scanning category user_interface Apr 22 20:35:05 volumio volumio[12383]: info: Scanning into folder /data/plugins/ Apr 22 20:35:05 volumio volumio[12383]: info: Plugin folders cleanup completed Apr 22 20:35:05 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:05 volumio volumio[12383]: info: ----- Core plugins startup ---- Apr 22 20:35:05 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugins from folder /volumio/app/plugins/ Apr 22 20:35:05 volumio volumio[12383]: info: Adding plugin upnp to MyMusic Plugins Apr 22 20:35:05 volumio volumio[12383]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 22 20:35:05 volumio volumio[12383]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugins from folder /data/plugins/ Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "system"... Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "appearance"... Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "network"... Apr 22 20:35:05 volumio volumio[12383]: info: Refreshing Cached IP Addresses Apr 22 20:35:05 volumio sudo[12410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 20:35:05 volumio sudo[12410]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:05 volumio sudo[12410]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:05 volumio sudo[12413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 20:35:05 volumio sudo[12413]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:05 volumio sudo[12413]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "services"... Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "alsa_controller"... Apr 22 20:35:05 volumio sudo[12416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 22 20:35:05 volumio sudo[12416]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:05 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "wizard"... Apr 22 20:35:05 volumio volumio[12383]: info: Loading plugin "networkfs"... Apr 22 20:35:05 volumio volumio[12383]: info: Starting Udev Watcher for removable devices Apr 22 20:35:05 volumio sudo[12421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:35:05 volumio sudo[12421]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:05 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:35:05 volumio volumio[12383]: info: Mounting Device Музыка_500г Apr 22 20:35:05 volumio sudo[12429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Музыка_500г -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:35:05 volumio sudo[12429]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:06 volumio sudo[12421]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:06 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:35:06 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:35:06 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:35:06 volumio sudo[12429]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:06 volumio ntfs-3g[12433]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 22 20:35:06 volumio ntfs-3g[12433]: Mounted /dev/sda1 (Read-Write, label "Музыка 500г", NTFS 3.1) Apr 22 20:35:06 volumio ntfs-3g[12433]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:35:06 volumio ntfs-3g[12433]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Apr 22 20:35:06 volumio ntfs-3g[12433]: Global ownership and permissions enforced, configuration type 7 Apr 22 20:35:06 volumio volumio[12383]: info: Mounting Device Музыка_500г_2 Apr 22 20:35:06 volumio volumio[12383]: /bin/mkdir: cannot create directory ‘/mnt/USB/Музыка_500г_2’: File exists Apr 22 20:35:06 volumio volumio[12383]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/USB/Музыка_500г_2" Apr 22 20:35:06 volumio volumio[12383]: /bin/mkdir: cannot create directory ‘/mnt/USB/Музыка_500г_2’: File exists Apr 22 20:35:06 volumio sudo[12440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Музыка_500г_2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:35:06 volumio sudo[12440]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:06 volumio sudo[12440]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:06 volumio volumio[12383]: Mount is denied because the NTFS volume is already exclusively opened. Apr 22 20:35:06 volumio volumio[12383]: The volume may be already mounted, or another software may use it which Apr 22 20:35:06 volumio volumio[12383]: could be identified for example by the help of the 'fuser' command. Apr 22 20:35:06 volumio volumio[12383]: error: Failed to mount Музыка_500г_2: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb1" "/mnt/USB/Музыка_500г_2" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 22 20:35:06 volumio volumio[12383]: Mount is denied because the NTFS volume is already exclusively opened. Apr 22 20:35:06 volumio volumio[12383]: The volume may be already mounted, or another software may use it which Apr 22 20:35:06 volumio volumio[12383]: could be identified for example by the help of the 'fuser' command. Apr 22 20:35:06 volumio volumio[12383]: info: Ignoring mount for partition: boot Apr 22 20:35:06 volumio volumio[12383]: info: Ignoring mount for partition: volumio Apr 22 20:35:06 volumio volumio[12383]: info: Ignoring mount for partition: volumio_data Apr 22 20:35:06 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "volumio_command_line_client"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "upnp"... Apr 22 20:35:06 volumio volumio[12383]: info: [1713818106545] Starting Upmpd Daemon Apr 22 20:35:06 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "my_music"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "mpd"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "upnp_browser"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "alarm-clock"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "airplay_emulation"... Apr 22 20:35:06 volumio volumio[12383]: info: Starting Shairport Sync Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "last_100"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "webradio"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "i2s_dacs"... Apr 22 20:35:06 volumio volumio[12383]: info: I2S DAC not set, start Auto-detection Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "volumiodiscovery"... Apr 22 20:35:06 volumio volumio[12383]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 20:35:06 volumio node[12383]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 20:35:06 volumio volumio[12383]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:35:06 volumio node[12383]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:35:06 volumio volumio[12383]: *** WARNING *** For more information see Apr 22 20:35:06 volumio node[12383]: *** WARNING *** For more information see Apr 22 20:35:06 volumio volumio[12383]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 20:35:06 volumio node[12383]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 20:35:06 volumio volumio[12383]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:35:06 volumio node[12383]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 20:35:06 volumio volumio[12383]: *** WARNING *** For more information see Apr 22 20:35:06 volumio node[12383]: *** WARNING *** For more information see Apr 22 20:35:06 volumio volumio[12383]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 22 20:35:06 volumio volumio[12383]: info: Discovery: Started advertising with name: Volumio Apr 22 20:35:06 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "outputs"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "albumart"... Apr 22 20:35:06 volumio volumio[12383]: info: Plugin example_plugin is not enabled Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "inputs"... Apr 22 20:35:06 volumio volumio[12383]: info: Loading plugin "updater_comm"... Apr 22 20:35:07 volumio volumio[12383]: info: Plugin mpdemulation is not enabled Apr 22 20:35:07 volumio volumio[12383]: info: Loading plugin "rest_api"... Apr 22 20:35:07 volumio volumio[12383]: info: Loading plugin "websocket"... Apr 22 20:35:07 volumio volumio[12383]: info: Loading i18n strings for locale ru Apr 22 20:35:07 volumio volumio[12383]: Updating browse sources language Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:35:07 volumio volumio[12383]: Forking 1 albumart workers Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::initPlayerControls Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: Express server listening on port 3000 Apr 22 20:35:07 volumio volumio[12383]: [Metrics] WebUI: 2s 171.13ms Apr 22 20:35:07 volumio volumio[12383]: info: Setting Device type: x86 Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::resetVolumioState Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::getcurrentVolume Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:07 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 22 20:35:07 volumio volumio[12383]: info: Completed loading Core Plugins Apr 22 20:35:07 volumio volumio[12383]: info: Preparing to generate the ALSA configuration file Apr 22 20:35:07 volumio volumio[12383]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Apr 22 20:35:07 volumio volumio[12383]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 22 20:35:07 volumio volumio[12383]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 1 Apr 22 20:35:07 volumio volumio[12383]: info: Reloading queue from file Apr 22 20:35:07 volumio volumio[12383]: info: Asound.conf file unchanged, so no further update is needed Apr 22 20:35:07 volumio volumio[12383]: info: Output device has changed, restarting MPD Apr 22 20:35:07 volumio volumio[12383]: info: Output device has changed, restarting Shairport Sync Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:07 volumio sudo[12464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 20:35:07 volumio sudo[12466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 20:35:07 volumio sudo[12466]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:07 volumio sudo[12464]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:07 volumio sudo[12464]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:07 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 20:35:07 volumio volumio[12383]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 20:35:07 volumio volumio[12383]: info: ___________ START PLUGINS ___________ Apr 22 20:35:07 volumio volumio[12383]: info: ControllerMpd::onStart: Initializing MPD Apr 22 20:35:07 volumio volumio[12383]: info: Creating MPD Configuration file Apr 22 20:35:07 volumio systemd[1]: mpd.service: Succeeded. Apr 22 20:35:07 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 20:35:07 volumio systemd[1]: Starting Music Player Daemon... Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 20:35:07 volumio volumio[12383]: info: [1713818107423] CoreMusicLibrary::Adding element Медиа-серверы Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:35:07 volumio sudo[12473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 20:35:07 volumio sudo[12473]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:07 volumio sudo[12473]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:07 volumio sudo[12476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 20:35:07 volumio sudo[12476]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: Starting albumart workers Apr 22 20:35:07 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 22 20:35:07 volumio systemd[1]: mpd.service: Succeeded. Apr 22 20:35:07 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 20:35:07 volumio volumio[12383]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:07 volumio systemd[1]: Starting Music Player Daemon... Apr 22 20:35:07 volumio volumio[12383]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 20:35:07 volumio volumio[12383]: info: [1713818107538] CoreMusicLibrary::Adding element Last_100 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 20:35:07 volumio volumio[12383]: info: [1713818107540] CoreMusicLibrary::Adding element Webradio Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 20:35:07 volumio volumio[12383]: info: Volumio Calling Home Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::setRepeat true single undefined Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:07 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::setRandom false Apr 22 20:35:07 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:07 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:07 volumio volumio[12383]: info: MPD Permissions set Apr 22 20:35:07 volumio volumio[12383]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 22 20:35:07 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 20:35:07 volumio volumio[12383]: info: Starting Shairport Sync Apr 22 20:35:07 volumio volumio[12383]: info: Starting Shairport Sync Apr 22 20:35:08 volumio volumio[12383]: info: Starting Shairport Sync Apr 22 20:35:08 volumio sudo[12510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 20:35:08 volumio sudo[12510]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:08 volumio sudo[12512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 20:35:08 volumio sudo[12512]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 20:35:08 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 20:35:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 20:35:08 volumio sudo[12516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 20:35:08 volumio sudo[12516]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 20:35:08 volumio sudo[12512]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:08 volumio sudo[12510]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:08 volumio volumio[12383]: info: Shairport-Sync Started Apr 22 20:35:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 20:35:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 22 20:35:08 volumio volumio[12383]: Error adding Membership: Error: addMembership EINVAL Apr 22 20:35:08 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 20:35:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 20:35:08 volumio volumio[12383]: info: Shairport-Sync Started Apr 22 20:35:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 20:35:08 volumio sudo[12516]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:08 volumio volumio[12383]: info: Shairport-Sync Started Apr 22 20:35:08 volumio volumio[12383]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 3 Apr 22 20:35:08 volumio mpd[12480]: Apr 22 20:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::volumioGetState Apr 22 20:35:08 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:08 volumio systemd[1]: Started Music Player Daemon. Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::volumioGetState Apr 22 20:35:08 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:08 volumio sudo[12476]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:08 volumio sudo[12466]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:08 volumio volumio[12383]: info: Completed starting Core Plugins Apr 22 20:35:08 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:08 volumio volumio[12383]: info: ----- MyVolumio plugins startup ---- Apr 22 20:35:08 volumio volumio[12383]: info: ------------------------------------------- Apr 22 20:35:08 volumio volumio[12383]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 20:35:08 volumio volumio[12383]: info: Listing playlists Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::volumioGetQueue Apr 22 20:35:08 volumio volumio[12383]: info: CoreStateMachine::getQueue Apr 22 20:35:08 volumio volumio[12383]: info: CorePlayQueue::getQueue Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 20:35:08 volumio volumio[12383]: error: MPD error: The expression evaluated to a falsy value: Apr 22 20:35:08 volumio volumio[12383]: assert.ok(self.idling) Apr 22 20:35:08 volumio volumio[12383]: error: The expression evaluated to a falsy value: Apr 22 20:35:08 volumio volumio[12383]: assert.ok(self.idling) Apr 22 20:35:08 volumio volumio[12383]: info: MPD running with PID12480 Apr 22 20:35:08 volumio volumio[12383]: ,establishing connection Apr 22 20:35:08 volumio volumio[12383]: error: MPD error: The expression evaluated to a falsy value: Apr 22 20:35:08 volumio volumio[12383]: assert.ok(self.idling) Apr 22 20:35:08 volumio volumio[12383]: error: The expression evaluated to a falsy value: Apr 22 20:35:08 volumio volumio[12383]: assert.ok(self.idling) Apr 22 20:35:08 volumio volumio[12383]: error: updateQueue error: null Apr 22 20:35:08 volumio volumio[12383]: info: Discovery: adding ef5abcd4-700a-4f91-b866-4e893b09d8f3 Apr 22 20:35:08 volumio volumio[12383]: info: Discovery: Found device Volumio Apr 22 20:35:08 volumio volumio[12383]: info: CoreCommandRouter::volumioGetState Apr 22 20:35:08 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:09 volumio volumio-remote-updater[547]: [2024-04-22 20:35:09] [connect] Successful connection Apr 22 20:35:09 volumio volumio-remote-updater[547]: [2024-04-22 20:35:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713818109 101 Apr 22 20:35:09 volumio volumio[12383]: 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 22 20:35:10 volumio sudo[12416]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:12 volumio sudo[12529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:35:12 volumio sudo[12529]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:12 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:35:12 volumio sudo[12529]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:12 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:35:12 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:35:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:35:12 volumio volumio[12383]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Apr 22 20:35:13 volumio volumio[12383]: info: Volumio called home Apr 22 20:35:13 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand update Apr 22 20:35:13 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:13 volumio volumio[12383]: info: Apr 22 20:35:13 volumio volumio[12383]: ---------------------------- MPD announces state update: update Apr 22 20:35:13 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:13 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:13 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:13 volumio volumio[12383]: info: Apr 22 20:35:13 volumio volumio[12383]: ---------------------------- MPD announces state update: update Apr 22 20:35:13 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:13 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:14 volumio volumio[12383]: info: Apr 22 20:35:14 volumio volumio[12383]: ---------------------------- MPD announces state update: update Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand update took 904 milliseconds Apr 22 20:35:14 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand status took 816 milliseconds Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand status took 812 milliseconds Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand status took 812 milliseconds Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand status took 811 milliseconds Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:14 volumio volumio[12383]: info: Command Router : Notfying DB Updatetrue Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:14 volumio volumio[12383]: info: Command Router : Notfying DB Updatetrue Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:14 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:14 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: No code Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:14 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: No code Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: ------------------------------ 890ms Apr 22 20:35:14 volumio volumio[12383]: info: ------------------------------ 888ms Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand status took 98 milliseconds Apr 22 20:35:14 volumio volumio[12383]: info: sendMpdCommand status took 96 milliseconds Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:14 volumio volumio[12383]: info: Command Router : Notfying DB Updatetrue Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:35:14 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:14 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:14 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: No code Apr 22 20:35:14 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:14 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:14 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:14 volumio volumio[12383]: info: ------------------------------ 141ms Apr 22 20:35:16 volumio sudo[12542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 20:35:16 volumio sudo[12542]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:16 volumio sudo[12545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 20:35:16 volumio sudo[12545]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:16 volumio sudo[12542]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:16 volumio sudo[12545]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:16 volumio sudo[12548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 22 20:35:16 volumio sudo[12548]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:16 volumio sudo[12548]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:16 volumio volumio[12383]: info: Upmpdcli Daemon Started Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 22 20:35:17 volumio volumio[12383]: info: Adding plugin bluetooth to MyMusic Plugins Apr 22 20:35:17 volumio volumio[12383]: info: Adding plugin multiroom to MyMusic Plugins Apr 22 20:35:17 volumio volumio[12383]: info: Adding plugin metavolumio to MyMusic Plugins Apr 22 20:35:17 volumio volumio[12383]: info: Adding plugin cd_controller to MyMusic Plugins Apr 22 20:35:17 volumio volumio[12383]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 22 20:35:17 volumio volumio[12383]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 22 20:35:17 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:17 volumio volumio[12383]: info: Starting MyVolumio Remote Streaming Endpoints Apr 22 20:35:17 volumio volumio[12383]: info: MyVolumio login type: Token Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 22 20:35:17 volumio volumio[12383]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 22 20:35:18 volumio volumio[12383]: info: Starting Streaming Service Transparent Proxy Apr 22 20:35:18 volumio volumio[12383]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 22 20:35:18 volumio volumio[12383]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 22 20:35:18 volumio volumio[12383]: info: Streaming services startup Apr 22 20:35:18 volumio volumio[12383]: info: Starting Streaming Daemon Apr 22 20:35:18 volumio sudo[12558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 22 20:35:18 volumio sudo[12558]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:18 volumio sudo[12558]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:18 volumio volumio[12383]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 22 20:35:18 volumio volumio[12383]: error: Cannot start Volumio Streaming Daemon Apr 22 20:35:18 volumio volumio[12383]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 22 20:35:18 volumio volumio[12383]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 22 20:35:18 volumio sudo[12565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:35:18 volumio sudo[12565]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:18 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:35:18 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:35:18 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:35:18 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:35:18 volumio sudo[12565]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:18 volumio volumio[12383]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Apr 22 20:35:18 volumio volumio[12383]: STREAMING PROXY: Starting server on port 3245 Apr 22 20:35:18 volumio volumio[12383]: Node JS runtime: 14 Apr 22 20:35:19 volumio volumio[12383]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 22 20:35:20 volumio volumio[12383]: info: MyVolumio token set successfully Apr 22 20:35:20 volumio volumio[12383]: info: MYVOLUMIO: Adding device Apr 22 20:35:20 volumio volumio[12383]: info: MYVOLUMIO: Evaluating Server Apr 22 20:35:21 volumio volumio[12383]: info: MyVolumio status changed Apr 22 20:35:21 volumio volumio[12383]: info: Streaming services startup Apr 22 20:35:21 volumio volumio[12383]: info: Starting Streaming Daemon Apr 22 20:35:21 volumio volumio[12383]: info: Removing browser output: myVolumio user plan is not superstar Apr 22 20:35:21 volumio volumio[12383]: info: Removing audio output: Apr 22 20:35:21 volumio volumio[12383]: info: Stoppping Tunnel 1 Apr 22 20:35:21 volumio sudo[12588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 22 20:35:21 volumio sudo[12588]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:21 volumio sudo[12590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 22 20:35:21 volumio sudo[12590]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:21 volumio sudo[12588]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:21 volumio sudo[12590]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:21 volumio volumio[12383]: error: Cannot start Volumio Streaming Daemon Apr 22 20:35:21 volumio volumio[12383]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 22 20:35:21 volumio volumio[12383]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 22 20:35:21 volumio volumio[12383]: info: Remote SSH Stopped Apr 22 20:35:23 volumio sudo[12595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:35:23 volumio sudo[12595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:23 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:35:23 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:35:23 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:35:23 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:35:23 volumio sudo[12595]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:23 volumio volumio[12383]: info: Cannot mount NAS music at system boot, trial number 4 ,retrying in 5 seconds Apr 22 20:35:26 volumio volumio[12383]: info: MPD Database updated - AlbumList cache refreshed Apr 22 20:35:26 volumio volumio[12383]: info: Apr 22 20:35:26 volumio volumio[12383]: ---------------------------- MPD announces state update: database Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: Apr 22 20:35:26 volumio volumio[12383]: ---------------------------- MPD announces state update: update Apr 22 20:35:26 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: MPD Database updated - AlbumList cache refreshed Apr 22 20:35:26 volumio volumio[12383]: info: Apr 22 20:35:26 volumio volumio[12383]: ---------------------------- MPD announces state update: database Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: Apr 22 20:35:26 volumio volumio[12383]: ---------------------------- MPD announces state update: update Apr 22 20:35:26 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: MPD Database updated - AlbumList cache refreshed Apr 22 20:35:26 volumio volumio[12383]: info: Apr 22 20:35:26 volumio volumio[12383]: ---------------------------- MPD announces state update: database Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: Apr 22 20:35:26 volumio volumio[12383]: ---------------------------- MPD announces state update: update Apr 22 20:35:26 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:26 volumio volumio[12383]: info: ControllerMpd::getState Apr 22 20:35:26 volumio volumio[12383]: verbose: ControllerMpd::sendMpdCommand status Apr 22 20:35:27 volumio volumio[12383]: info: sendMpdCommand status took 940 milliseconds Apr 22 20:35:27 volumio volumio[12383]: info: sendMpdCommand status took 940 milliseconds Apr 22 20:35:27 volumio volumio[12383]: info: sendMpdCommand status took 940 milliseconds Apr 22 20:35:27 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:27 volumio volumio[12383]: info: Command Router : Notfying DB Updatefalse Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:35:27 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:27 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:27 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:27 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: No code Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:27 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: No code Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: ------------------------------ 1001ms Apr 22 20:35:27 volumio volumio[12383]: info: ------------------------------ 1001ms Apr 22 20:35:27 volumio volumio[12383]: info: Setting Geolocation for MyVolumio to eu4 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:27 volumio volumio[12383]: info: sendMpdCommand status took 1578 milliseconds Apr 22 20:35:27 volumio volumio[12383]: info: sendMpdCommand status took 1579 milliseconds Apr 22 20:35:27 volumio volumio[12383]: info: sendMpdCommand status took 1578 milliseconds Apr 22 20:35:27 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:27 volumio volumio[12383]: info: Command Router : Notfying DB Updatefalse Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:35:27 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:27 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:27 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:27 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: No code Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:27 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: No code Apr 22 20:35:27 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:27 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:27 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:27 volumio volumio[12383]: info: ------------------------------ 1627ms Apr 22 20:35:27 volumio volumio[12383]: info: ------------------------------ 1628ms Apr 22 20:35:28 volumio volumio[12383]: info: sendMpdCommand status took 2180 milliseconds Apr 22 20:35:28 volumio volumio[12383]: info: sendMpdCommand status took 2180 milliseconds Apr 22 20:35:28 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:28 volumio volumio[12383]: info: Command Router : Notfying DB Updatefalse Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::Close All Modals sent Apr 22 20:35:28 volumio volumio[12383]: verbose: ControllerMpd::parseState Apr 22 20:35:28 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:28 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:28 volumio volumio[12383]: info: No code Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:28 volumio volumio[12383]: info: ControllerMpd::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::servicePushState Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 22 20:35:28 volumio volumio[12383]: verbose: CURRENT POSITION 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::syncState stateService stop Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::syncState currentStatus stop Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:28 volumio volumio[12383]: info: No code Apr 22 20:35:28 volumio volumio[12383]: info: CoreStateMachine::pushState Apr 22 20:35:28 volumio volumio[12383]: info: CorePlayQueue::getTrack 0 Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::volumioPushState Apr 22 20:35:28 volumio volumio[12383]: info: ------------------------------ 2225ms Apr 22 20:35:28 volumio volumio[12383]: info: ------------------------------ 2225ms Apr 22 20:35:28 volumio volumio[12383]: info: Updating MyVolumio device info Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:28 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 20:35:28 volumio volumio[12383]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 22 20:35:28 volumio sudo[12607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=WORKGROUP,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.8.105/F /mnt/NAS/music Apr 22 20:35:28 volumio sudo[12607]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 20:35:28 volumio kernel: CIFS: Attempting to mount //192.168.8.105/F Apr 22 20:35:29 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Apr 22 20:35:29 volumio kernel: CIFS: VFS: \\192.168.8.105 Send error in SessSetup = -13 Apr 22 20:35:29 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Apr 22 20:35:29 volumio sudo[12607]: pam_unix(sudo:session): session closed for user root Apr 22 20:35:29 volumio volumio[12383]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 22 20:35:29 volumio volumio[12383]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 22 20:35:32 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 22 20:35:32 volumio volumio[12383]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 20:35:32 volumio volumio[12383]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 20:35:32 volumio volumio[12383]: TypeError: Cannot read property 'length' of undefined Apr 22 20:35:32 volumio volumio[12383]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 22 20:35:32 volumio volumio[12383]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 22 20:35:32 volumio volumio[12383]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 22 20:35:32 volumio volumio[12383]: at Parser.emit (events.js:400:28) Apr 22 20:35:32 volumio volumio[12383]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 22 20:35:32 volumio volumio[12383]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 22 20:35:32 volumio volumio[12383]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 22 20:35:32 volumio volumio[12383]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 22 20:35:32 volumio volumio[12383]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 22 20:35:32 volumio volumio[12383]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 22 20:35:32 volumio volumio[12383]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 22 20:35:32 volumio volumio[12383]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 22 20:35:32 volumio volumio[12383]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 22 20:35:32 volumio volumio[12383]: at IncomingMessage.emit (events.js:412:35) Apr 22 20:35:32 volumio volumio[12383]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 22 20:35:32 volumio volumio[12383]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 22 20:35:32 volumio volumio[12383]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 20:35:32 volumio sudo[12621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 20:34 Apr 22 20:35:32 volumio sudo[12621]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b51559ff3f3719e35ff52cb9ccf2ff401b5ecb06" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="9f81dc1810002a5ad8861a42d98d57bc06a5d5d3" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 17 Apr 2024 08:25:04 PM CEST" VOLUMIO_VERSION="3.649" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="bb8d02f8f512a28dca8d2cfad424e542"