-- Logs begin at Sun 2025-01-05 08:18:59 UTC, end at Sat 2025-03-08 12:57:38 UTC. -- Mar 08 12:56:00 volumio volumio[15902]: info: Cannot mount NAS mmcblk0p27 at system boot, trial number 4 ,retrying in 5 seconds Mar 08 12:56:01 volumio volumio-streaming-daemon[16107]: Environment: production Mar 08 12:56:01 volumio volumio[15902]: info: Fetching Streaming Services browse cache Mar 08 12:56:04 volumio sudo[16146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.4/music /mnt/NAS/NAS Mar 08 12:56:04 volumio sudo[16146]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 12:56:04 volumio sudo[16146]: pam_unix(sudo:session): session closed for user root Mar 08 12:56:04 volumio volumio[15902]: info: Cannot mount NAS NAS at system boot, trial number 4 ,retrying in 5 seconds Mar 08 12:56:05 volumio sudo[16114]: pam_unix(sudo:session): session closed for user root Mar 08 12:56:05 volumio volumio[15902]: info: Cannot mount NAS local at system boot, trial number 2 ,retrying in 5 seconds Mar 08 12:56:05 volumio volumio[15902]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Mar 08 12:56:09 volumio volumio[15902]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=70a0abfbb8a35357eae9b34d5fd61859" http://updates.volumio.org:7070/downloader-v1/track-device Mar 08 12:56:09 volumio volumio[15902]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 08 12:56:09 volumio volumio[15902]: Dload Upload Total Spent Left Speed Mar 08 12:56:09 volumio volumio[15902]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 08 12:56:09 volumio volumio[15902]: retrying in 5 seconds, trial 1 Mar 08 12:56:09 volumio volumio[15902]: Volumio Calling Home Mar 08 12:56:09 volumio sudo[16175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.4/music /mnt/NAS/NAS Mar 08 12:56:09 volumio sudo[16175]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 12:56:09 volumio sudo[16175]: pam_unix(sudo:session): session closed for user root Mar 08 12:56:09 volumio volumio[15902]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Mar 08 12:56:10 volumio sudo[16185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/usb /mnt/NAS/local Mar 08 12:56:10 volumio sudo[16185]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 12:56:16 volumio sudo[16185]: pam_unix(sudo:session): session closed for user root Mar 08 12:56:16 volumio volumio[15902]: info: Cannot mount NAS local at system boot, trial number 3 ,retrying in 5 seconds Mar 08 12:56:16 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 12:56:16 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 12:56:19 volumio volumio[15902]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=70a0abfbb8a35357eae9b34d5fd61859" http://updates.volumio.org:7070/downloader-v1/track-device Mar 08 12:56:19 volumio volumio[15902]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 08 12:56:19 volumio volumio[15902]: Dload Upload Total Spent Left Speed Mar 08 12:56:19 volumio volumio[15902]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 08 12:56:19 volumio volumio[15902]: retrying in 5 seconds, trial 2 Mar 08 12:56:19 volumio volumio[15902]: Volumio Calling Home Mar 08 12:56:21 volumio sudo[16230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/usb /mnt/NAS/local Mar 08 12:56:21 volumio sudo[16230]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 12:56:27 volumio sudo[16230]: pam_unix(sudo:session): session closed for user root Mar 08 12:56:27 volumio volumio[15902]: info: Cannot mount NAS local at system boot, trial number 4 ,retrying in 5 seconds Mar 08 12:56:32 volumio sudo[16286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/usb /mnt/NAS/local Mar 08 12:56:32 volumio sudo[16286]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 12:56:38 volumio sudo[16286]: pam_unix(sudo:session): session closed for user root Mar 08 12:56:38 volumio volumio[15902]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Mar 08 12:57:01 volumio kernel: aml_spdif_dai: aiu 958 playback disable Mar 08 12:57:01 volumio volumio[15902]: info: Mar 08 12:57:01 volumio volumio[15902]: ---------------------------- MPD announces system playlist update Mar 08 12:57:01 volumio volumio[15902]: info: Ignoring MPD Status Update Mar 08 12:57:01 volumio volumio[15902]: info: Mar 08 12:57:01 volumio volumio[15902]: ---------------------------- MPD announces state update: player Mar 08 12:57:01 volumio volumio[15902]: info: ControllerMpd::getState Mar 08 12:57:01 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand status Mar 08 12:57:01 volumio volumio[15902]: error: updateQueue error: null Mar 08 12:57:01 volumio volumio[15902]: info: ------------------------------ 18ms Mar 08 12:57:01 volumio volumio[15902]: verbose: ControllerMpd::parseState Mar 08 12:57:01 volumio volumio[15902]: info: ControllerMpd::pushState Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::servicePushState Mar 08 12:57:01 volumio volumio[15902]: info: CoreStateMachine::pushState Mar 08 12:57:01 volumio volumio[15902]: info: CorePlayQueue::getTrack 0 Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::volumioPushState Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 12:57:01 volumio volumio[15902]: info: CorePlayQueue::getTrack 0 Mar 08 12:57:01 volumio volumio[15902]: 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} Mar 08 12:57:01 volumio volumio[15902]: verbose: CURRENT POSITION 0 Mar 08 12:57:01 volumio volumio[15902]: info: CoreStateMachine::syncState stateService stop Mar 08 12:57:01 volumio volumio[15902]: info: CoreStateMachine::syncState currentStatus stop Mar 08 12:57:01 volumio volumio[15902]: info: CoreStateMachine::pushState Mar 08 12:57:01 volumio volumio[15902]: info: CorePlayQueue::getTrack 0 Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::volumioPushState Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 12:57:01 volumio volumio[15902]: info: No code Mar 08 12:57:01 volumio volumio[15902]: info: CoreStateMachine::pushState Mar 08 12:57:01 volumio volumio[15902]: info: CorePlayQueue::getTrack 0 Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::volumioPushState Mar 08 12:57:01 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 12:57:01 volumio volumio[15902]: info: ------------------------------ 67ms Mar 08 12:57:10 volumio volumio[15902]: info: CoreCommandRouter::volumioGetState Mar 08 12:57:10 volumio volumio[15902]: info: CorePlayQueue::getTrack 0 Mar 08 12:57:12 volumio volumio[15902]: info: CoreCommandRouter::volumioPlay Mar 08 12:57:12 volumio volumio[15902]: UNSET VOLATILE Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::play index 151 Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::stop Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 12:57:12 volumio volumio[15902]: UNSET VOLATILE Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::play index undefined Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 12:57:12 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:12 volumio volumio[15902]: info: CoreStateMachine::startPlaybackTimer Mar 08 12:57:12 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:12 volumio volumio[15902]: verbose: ControllerMpd::clearAddPlayTracks NAS/mmcblk0p27/mp3/09 How You Like It.m4a Mar 08 12:57:12 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 12:57:12 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 12:57:12 volumio volumio[15902]: info: Mar 08 12:57:12 volumio volumio[15902]: ---------------------------- MPD announces system playlist update Mar 08 12:57:12 volumio volumio[15902]: info: Ignoring MPD Status Update Mar 08 12:57:12 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand add "NAS/mmcblk0p27/mp3/09 How You Like It.m4a" Mar 08 12:57:12 volumio volumio[15902]: error: updateQueue error: null Mar 08 12:57:12 volumio volumio[15902]: info: Mar 08 12:57:12 volumio volumio[15902]: ---------------------------- MPD announces system playlist update Mar 08 12:57:12 volumio volumio[15902]: info: Ignoring MPD Status Update Mar 08 12:57:12 volumio volumio[15902]: info: ------------------------------ 9ms Mar 08 12:57:12 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand play Mar 08 12:57:12 volumio volumio[15902]: info: ------------------------------ 8ms Mar 08 12:57:12 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, same source mode(0) Mar 08 12:57:12 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Mar 08 12:57:12 volumio kernel: aml_spdif_dai: iec958 mode PCM16 Mar 08 12:57:12 volumio kernel: aml_audio_hw: IEC958 16bit Mar 08 12:57:12 volumio kernel: hdmitx: audio: aout notify rate 48000 Mar 08 12:57:12 volumio kernel: hdmitx: audio: aout notify size 16 Mar 08 12:57:12 volumio kernel: hdmitx: audio: no update Mar 08 12:57:13 volumio kernel: aml_spdif_dai: aiu 958 playback enable Mar 08 12:57:13 volumio volumio[15902]: info: Mar 08 12:57:13 volumio volumio[15902]: ---------------------------- MPD announces state update: player Mar 08 12:57:13 volumio volumio[15902]: info: ControllerMpd::getState Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand status Mar 08 12:57:13 volumio volumio[15902]: info: Mar 08 12:57:13 volumio volumio[15902]: ---------------------------- MPD announces state update: player Mar 08 12:57:13 volumio volumio[15902]: info: ControllerMpd::getState Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand status Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::parseState Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::parseState Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::parseTrackInfo Mar 08 12:57:13 volumio volumio[15902]: info: ControllerMpd::pushState Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::servicePushState Mar 08 12:57:13 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:13 volumio volumio[15902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":662,"duration":214,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"272 Kbps","isStreaming":false,"title":"How You Like It","artist":"Ramzi","album":"Chapter One","uri":"NAS/mmcblk0p27/mp3/09 How You Like It.m4a","trackType":"m4a"} Mar 08 12:57:13 volumio volumio[15902]: verbose: CURRENT POSITION 151 Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::syncState stateService play Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::syncState currentStatus stop Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::pushState Mar 08 12:57:13 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::volumioPushState Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 12:57:13 volumio volumio[15902]: info: ------------------------------ 72ms Mar 08 12:57:13 volumio volumio[15902]: verbose: ControllerMpd::parseTrackInfo Mar 08 12:57:13 volumio volumio[15902]: info: ControllerMpd::pushState Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::servicePushState Mar 08 12:57:13 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:13 volumio volumio[15902]: verbose: STATE SERVICE {"status":"play","position":0,"seek":673,"duration":214,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"272 Kbps","isStreaming":false,"title":"How You Like It","artist":"Ramzi","album":"Chapter One","uri":"NAS/mmcblk0p27/mp3/09 How You Like It.m4a","trackType":"m4a"} Mar 08 12:57:13 volumio volumio[15902]: verbose: CURRENT POSITION 151 Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::syncState stateService play Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::syncState currentStatus play Mar 08 12:57:13 volumio volumio[15902]: info: Received an update from plugin. extracting info from payload Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::pushState Mar 08 12:57:13 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::volumioPushState Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 12:57:13 volumio volumio[15902]: info: CoreStateMachine::pushState Mar 08 12:57:13 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::volumioPushState Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 12:57:13 volumio volumio[15902]: info: ------------------------------ 135ms Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 12:57:13 volumio volumio[15902]: info: Discovery: Getting this device information Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::volumioGetState Mar 08 12:57:13 volumio volumio[15902]: info: CorePlayQueue::getTrack 151 Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 08 12:57:13 volumio volumio[15902]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 08 12:57:37 volumio volumio[15902]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 12:57:37 volumio volumio[15902]: { Error: connect ECONNREFUSED 103.230.123.190:443 Mar 08 12:57:37 volumio volumio[15902]: at Object._errnoException (util.js:1022:11) Mar 08 12:57:37 volumio volumio[15902]: at _exceptionWithHostPort (util.js:1044:20) Mar 08 12:57:37 volumio volumio[15902]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 08 12:57:37 volumio volumio[15902]: code: 'ECONNREFUSED', Mar 08 12:57:37 volumio volumio[15902]: errno: 'ECONNREFUSED', Mar 08 12:57:37 volumio volumio[15902]: syscall: 'connect', Mar 08 12:57:37 volumio volumio[15902]: address: '103.230.123.190', Mar 08 12:57:37 volumio volumio[15902]: port: 443 } Mar 08 12:57:37 volumio volumio[15902]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 12:57:38 volumio sudo[16496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 12:56 Mar 08 12:57:38 volumio sudo[16496]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"