-- Logs begin at Wed 2024-03-20 00:29:52 UTC, end at Fri 2024-05-03 20:06:36 UTC. -- May 03 20:05:04 volumio volumio[7277]: info: Plugin mpdemulation is not enabled May 03 20:05:04 volumio volumio[7277]: info: Loading plugin "rest_api"... May 03 20:05:05 volumio volumio[7277]: info: Loading plugin "websocket"... May 03 20:05:06 volumio volumio[7277]: info: ___________ START PLUGINS ___________ May 03 20:05:06 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:09 volumio volumio[7277]: Forking 1 albumart workers May 03 20:05:10 volumio volumio[7277]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 03 20:05:10 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:12 volumio volumio[7277]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 03 20:05:12 volumio volumio[7277]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 03 20:05:12 volumio volumio[7277]: info: [1714766712274] CoreMusicLibrary::Adding element Last_100 May 03 20:05:12 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 20:05:12 volumio volumio[7277]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 03 20:05:12 volumio volumio[7277]: info: [1714766712623] CoreMusicLibrary::Adding element Webradio May 03 20:05:12 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 20:05:12 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 03 20:05:13 volumio volumio[7277]: info: ------------------------------------------- May 03 20:05:13 volumio volumio[7277]: info: ----- MyVolumio plugins startup ---- May 03 20:05:13 volumio volumio[7277]: info: ------------------------------------------- May 03 20:05:13 volumio volumio[7277]: info: [MyVolumio PluginManager] Fetching plans data.... May 03 20:05:13 volumio volumio[7277]: info: Loading i18n strings for locale en May 03 20:05:14 volumio volumio[7277]: Updating browse sources language May 03 20:05:14 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 20:05:14 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 20:05:14 volumio volumio[7277]: info: CoreCommandRouter::initPlayerControls May 03 20:05:15 volumio volumio-remote-updater[22133]: [2024-05-03 20:05:14] [connect] Successful connection May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 20:05:15 volumio volumio[7277]: info: BOOT COMPLETED May 03 20:05:15 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 20:05:22 volumio volumio[7277]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo May 03 20:05:22 volumio volumio[7277]: info: CoreCommandRouter::Close All Modals sent May 03 20:05:23 volumio volumio[7277]: info: CoreCommandRouter::Close All Modals sent May 03 20:05:23 volumio volumio[7277]: Express server listening on port 3000 May 03 20:05:23 volumio volumio[7277]: Volumio Calling Home May 03 20:05:26 volumio volumio[7277]: info: CoreStateMachine::resetVolumioState May 03 20:05:26 volumio volumio[7277]: info: CoreStateMachine::getcurrentVolume May 03 20:05:26 volumio volumio[7277]: info: CoreCommandRouter::volumioRetrievevolume May 03 20:05:30 volumio volumio-remote-updater[22133]: [2024-05-03 20:05:30] [connect] Successful connection May 03 20:05:32 volumio volumio[7277]: info: Cannot mount NAS WD_my_cloud at system boot, trial number 2 ,retrying in 5 seconds May 03 20:05:33 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 03 20:05:35 volumio sudo[7366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 03 20:05:35 volumio sudo[7366]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 20:05:35 volumio sudo[7366]: pam_unix(sudo:session): session closed for user root May 03 20:05:35 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 03 20:05:37 volumio volumio[7277]: info: Cannot mount NAS WD_my_cloud at system boot, trial number 3 ,retrying in 5 seconds May 03 20:05:42 volumio volumio[7277]: info: CoreStateMachine::pushState May 03 20:05:42 volumio volumio[7277]: info: CoreStateMachine::getState May 03 20:05:42 volumio volumio[7277]: info: CorePlayQueue::getTrack 0 May 03 20:05:42 volumio volumio[7277]: info: CoreCommandRouter::volumioPushState May 03 20:05:42 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 20:05:42 volumio volumio[7277]: info: CoreStateMachine::updateTrackBlock May 03 20:05:42 volumio volumio[7277]: info: CorePlayQueue::getTrackBlock May 03 20:05:42 volumio volumio[7277]: info: CoreCommandRouter::volumioRetrievevolume May 03 20:05:42 volumio volumio[7277]: Starting albumart workers May 03 20:05:43 volumio volumio[7277]: info: Setting Device type: Raspberry PI May 03 20:05:43 volumio volumio[7277]: info: MPD running with PID672 ,establishing connection May 03 20:05:43 volumio volumio[7277]: info: Cannot mount NAS WD_my_cloud at system boot, trial number 4 ,retrying in 5 seconds May 03 20:05:44 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 03 20:05:44 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 20:05:45 volumio volumio-remote-updater[22133]: [2024-05-03 20:05:45] [connect] Successful connection May 03 20:05:51 volumio volumio[7277]: info: CoreStateMachine::pushState May 03 20:05:51 volumio volumio[7277]: info: CoreStateMachine::getState May 03 20:05:51 volumio volumio[7277]: info: CorePlayQueue::getTrack 0 May 03 20:05:51 volumio volumio[7277]: info: CoreCommandRouter::volumioPushState May 03 20:05:51 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 20:05:51 volumio volumio[7277]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 03 20:05:53 volumio volumio[7277]: info: May 03 20:05:53 volumio volumio[7277]: ---------------------------- Client requests Volume 20 May 03 20:05:53 volumio volumio[7277]: info: VolumeController::SetAlsaVolume20 May 03 20:05:53 volumio volumio[7277]: info: CoreStateMachine::pushState May 03 20:05:53 volumio volumio[7277]: info: CoreStateMachine::getState May 03 20:05:53 volumio volumio[7277]: info: CorePlayQueue::getTrack 0 May 03 20:05:53 volumio volumio[7277]: info: CoreCommandRouter::volumioPushState May 03 20:05:53 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 20:05:55 volumio volumio[7277]: Upnp client error: Error: This socket has been ended by the other party May 03 20:05:55 volumio volumio[7277]: Upnp client error: Error: This socket has been ended by the other party May 03 20:05:56 volumio volumio[7277]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.714&uuid=87e753172ed255e419bc26473cd61be7" http://updates.volumio.org:7070/downloader-v1/track-device May 03 20:05:56 volumio volumio[7277]: % Total % Received % Xferd Average Speed Time Time Time Current May 03 20:05:56 volumio volumio[7277]: Dload Upload Total Spent Left Speed May 03 20:05:56 volumio volumio[7277]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 03 20:05:56 volumio volumio[7277]: retrying in 5 seconds, trial 0 May 03 20:05:56 volumio volumio[7277]: Volumio Calling Home May 03 20:05:56 volumio volumio[7277]: info: Reloading queue from file May 03 20:05:57 volumio volumio[7277]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory May 03 20:05:57 volumio volumio[7277]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) May 03 20:05:57 volumio volumio[7277]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) May 03 20:05:57 volumio volumio[7277]: at emitOne (events.js:116:13) May 03 20:05:57 volumio volumio[7277]: at Socket.emit (events.js:211:7) May 03 20:05:57 volumio volumio[7277]: at addChunk (_stream_readable.js:263:12) May 03 20:05:57 volumio volumio[7277]: at readableAddChunk (_stream_readable.js:246:13) May 03 20:05:57 volumio volumio[7277]: at Socket.Readable.push (_stream_readable.js:208:10) May 03 20:05:57 volumio volumio[7277]: at Pipe.onread (net.js:607:20) May 03 20:05:59 volumio volumio[7277]: info: Setting volume on startup at 20 May 03 20:05:59 volumio volumio[7277]: info: CoreStateMachine::setRepeat false single undefined May 03 20:05:59 volumio volumio[7277]: info: CoreStateMachine::pushState May 03 20:05:59 volumio volumio[7277]: info: CoreStateMachine::getState May 03 20:05:59 volumio volumio[7277]: info: CorePlayQueue::getTrack 0 May 03 20:05:59 volumio volumio[7277]: info: CoreCommandRouter::volumioPushState May 03 20:05:59 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 20:05:59 volumio volumio[7277]: info: CoreStateMachine::setRandom false May 03 20:05:59 volumio volumio[7277]: info: CoreStateMachine::pushState May 03 20:05:59 volumio volumio[7277]: info: CoreStateMachine::getState May 03 20:05:59 volumio volumio[7277]: info: CorePlayQueue::getTrack 0 May 03 20:05:59 volumio volumio[7277]: info: CoreCommandRouter::volumioPushState May 03 20:05:59 volumio volumio[7277]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 20:06:00 volumio volumio-remote-updater[22133]: [2024-05-03 20:06:00] [connect] Successful connection May 03 20:06:02 volumio volumio[7277]: info: Starting Shairport Sync May 03 20:06:02 volumio volumio[7277]: info: Starting Shairport Sync May 03 20:06:03 volumio sudo[7405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 03 20:06:03 volumio sudo[7405]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 20:06:03 volumio sudo[7407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 03 20:06:04 volumio sudo[7407]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 20:06:04 volumio sudo[7409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 03 20:06:04 volumio sudo[7409]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 20:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 03 20:06:05 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 03 20:06:05 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 03 20:06:05 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 03 20:06:05 volumio sudo[7405]: pam_unix(sudo:session): session closed for user root May 03 20:06:05 volumio sudo[7407]: pam_unix(sudo:session): session closed for user root May 03 20:06:05 volumio sudo[7409]: pam_unix(sudo:session): session closed for user root May 03 20:06:13 volumio volumio[7277]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.714&uuid=87e753172ed255e419bc26473cd61be7" http://updates.volumio.org:7070/downloader-v1/track-device May 03 20:06:13 volumio volumio[7277]: % Total % Received % Xferd Average Speed Time Time Time Current May 03 20:06:13 volumio volumio[7277]: Dload Upload Total Spent Left Speed May 03 20:06:13 volumio volumio[7277]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 03 20:06:13 volumio volumio[7277]: retrying in 5 seconds, trial 1 May 03 20:06:13 volumio volumio[7277]: Volumio Calling Home May 03 20:06:15 volumio volumio-remote-updater[22133]: [2024-05-03 20:06:15] [connect] Successful connection May 03 20:06:19 volumio volumio[7277]: info: Upmpdcli Daemon Started May 03 20:06:19 volumio volumio[7277]: info: Shairport-Sync Started May 03 20:06:19 volumio volumio[7277]: Error adding Membership: Error: addMembership EINVAL May 03 20:06:19 volumio volumio[7277]: info: Shairport-Sync Started May 03 20:06:19 volumio volumio[7277]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 20:06:19 volumio volumio[7277]: { Error: ENOSPC: no space left on device, write errno: -28, code: 'ENOSPC', syscall: 'write' } May 03 20:06:19 volumio volumio[7277]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 20:06:30 volumio volumio-remote-updater[22133]: [2024-05-03 20:06:30] [connect] Successful connection May 03 20:06:36 volumio sudo[7460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 20:05 May 03 20:06:36 volumio sudo[7460]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="14e505ebc0c0b6541b6ad04e5b86c2128df58d23" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="182fd1481f62b921e0a6fbcd29a33d75c95ccac8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Mar 2 23:44:51 CET 2020" VOLUMIO_VERSION="2.714" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="61eaeea5a6d5085176252b0f9119e64f"