-- Logs begin at Tue 2024-04-30 12:17:13 UTC, end at Tue 2024-04-30 12:46:10 UTC. -- Apr 30 12:45:48 volumio systemd[1]: Time has been changed Apr 30 12:45:48 volumio volumio[945]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 30 12:45:48 volumio volumio[945]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 30 12:45:48 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 30 12:45:48 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 30 12:45:48 volumio volumio[945]: info: Starting MyVolumio Remote Streaming Endpoints Apr 30 12:45:48 volumio volumio[945]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 30 12:45:48 volumio volumio[945]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 30 12:45:48 volumio volumio[945]: info: Streaming services startup Apr 30 12:45:48 volumio volumio[945]: info: Starting Streaming Daemon Apr 30 12:45:48 volumio volumio[945]: info: MyVolumio not started Apr 30 12:45:48 volumio volumio[945]: info: Initializing device activation check Apr 30 12:45:48 volumio sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 30 12:45:48 volumio sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:45:48 volumio volumio[945]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 30 12:45:48 volumio systemd[1]: Stopping Volumio Streaming Daemon... Apr 30 12:45:48 volumio systemd[1]: Starting Volumio Streaming Daemon... Apr 30 12:45:48 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 30 12:45:48 volumio sudo[1351]: pam_unix(sudo:session): session closed for user root Apr 30 12:45:48 volumio volumio[945]: info: CorePlayQueue::getTrack 2 Apr 30 12:45:48 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:48 volumio volumio[945]: info: Prefetching next song Apr 30 12:45:48 volumio volumio[945]: info: DOING PREFETCH IN MPD Apr 30 12:45:48 volumio volumio[945]: info: ControllerMpd::sendMpdCommand add "USB/HDD_1T/12345/张洪量 _ 莫文蔚 - 广岛之恋.mp3" Apr 30 12:45:48 volumio volumio[945]: info: CoreStateMachine::startPlaybackTimer Apr 30 12:45:48 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:48 volumio volumio[945]: info: sending command... Apr 30 12:45:48 volumio volumio-streaming-daemon[1357]: ############################ Apr 30 12:45:48 volumio volumio-streaming-daemon[1357]: # Volumio Streaming Daemon # Apr 30 12:45:48 volumio volumio-streaming-daemon[1357]: # Running on port 7777 # Apr 30 12:45:48 volumio volumio-streaming-daemon[1357]: ############################ Apr 30 12:45:49 volumio volumio[945]: info: Apr 30 12:45:49 volumio volumio[945]: ---------------------------- MPD announces system playlist update Apr 30 12:45:49 volumio volumio[945]: info: Ignoring MPD Status Update Apr 30 12:45:49 volumio volumio[945]: info: parsing response... Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::sendMpdCommand consume 1 Apr 30 12:45:49 volumio volumio[945]: info: sending command... Apr 30 12:45:49 volumio volumio[945]: info: Apr 30 12:45:49 volumio volumio[945]: ---------------------------- MPD announces system playlist update Apr 30 12:45:49 volumio volumio[945]: info: Ignoring MPD Status Update Apr 30 12:45:49 volumio volumio[945]: info: Apr 30 12:45:49 volumio volumio[945]: ---------------------------- MPD announces state update: options Apr 30 12:45:49 volumio volumio[945]: info: ------------------------------ 9ms Apr 30 12:45:49 volumio volumio[945]: info: parsing response... Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::getState Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::sendMpdCommand status Apr 30 12:45:49 volumio volumio[945]: info: ------------------------------ 5ms Apr 30 12:45:49 volumio volumio[945]: info: sending command... Apr 30 12:45:49 volumio volumio[945]: info: Apr 30 12:45:49 volumio volumio[945]: ---------------------------- MPD announces state update: options Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::getState Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::sendMpdCommand status Apr 30 12:45:49 volumio volumio[945]: info: sending command... Apr 30 12:45:49 volumio volumio[945]: info: parsing response... Apr 30 12:45:49 volumio volumio[945]: info: parsing response... Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::parseState Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::parseState Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:45:49 volumio volumio[945]: info: sending command... Apr 30 12:45:49 volumio volumio[945]: info: sending command... Apr 30 12:45:49 volumio volumio[945]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%9F%E5%BA%AD%E8%8B%87/%E5%86%AC%E5%AD%A3%E5%88%B0%E5%8F%B0%E5%8C%97%E6%9D%A5%E7%9C%8B%E9%9B%A8/dec0032c-3dce-469c-b588-8b7962f2cffc.jpg' Apr 30 12:45:49 volumio volumio[945]: info: parsing response... Apr 30 12:45:49 volumio volumio[945]: info: parsing response... Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::parseTrackInfo Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::parseTrackInfo Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::pushState Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::servicePushState Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::syncState Apr 30 12:45:49 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:49 volumio volumio[945]: info: STATE SERVICE {"status":"play","position":0,"seek":3761,"duration":309,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"冬季到台北来看雨","artist":"孟庭苇","album":"冬季到台北来看雨","uri":"USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac","trackType":"flac"} Apr 30 12:45:49 volumio volumio[945]: info: CURRENT POSITION 0 Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::syncState stateService play Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::syncState currentStatus play Apr 30 12:45:49 volumio volumio[945]: info: Received an update from plugin. extracting info from payload Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::pushState Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::getState Apr 30 12:45:49 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::volumioPushState Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::pushState Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::getState Apr 30 12:45:49 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::volumioPushState Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:45:49 volumio sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:45:49 volumio sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:45:49 volumio sudo[1366]: pam_unix(sudo:session): session closed for user root Apr 30 12:45:49 volumio volumio[945]: info: ControllerMpd::pushState Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::servicePushState Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::syncState Apr 30 12:45:49 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:49 volumio volumio[945]: info: STATE SERVICE {"status":"play","position":0,"seek":3761,"duration":309,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"冬季到台北来看雨","artist":"孟庭苇","album":"冬季到台北来看雨","uri":"USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac","trackType":"flac"} Apr 30 12:45:49 volumio volumio[945]: info: CURRENT POSITION 0 Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::syncState stateService play Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::syncState currentStatus play Apr 30 12:45:49 volumio volumio[945]: info: Received an update from plugin. extracting info from payload Apr 30 12:45:49 volumio sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::pushState Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::getState Apr 30 12:45:49 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::volumioPushState Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:45:49 volumio sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::pushState Apr 30 12:45:49 volumio volumio[945]: info: CoreStateMachine::getState Apr 30 12:45:49 volumio volumio[945]: info: CorePlayQueue::getTrack 0 Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::volumioPushState Apr 30 12:45:49 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:45:49 volumio sudo[1373]: pam_unix(sudo:session): session closed for user root Apr 30 12:45:49 volumio sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:45:49 volumio sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:45:49 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:45:49 volumio volumio[945]: info: ------------------------------ 131ms Apr 30 12:45:49 volumio volumio[945]: info: ------------------------------ 129ms Apr 30 12:45:49 volumio sudo[1380]: pam_unix(sudo:session): session closed for user root Apr 30 12:45:49 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:45:49 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root Apr 30 12:45:51 volumio volumio[945]: info: Fetching Streaming Services browse cache Apr 30 12:45:51 volumio volumio[945]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Apr 30 12:45:51 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 30 12:45:51 volumio volumio[945]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Apr 30 12:45:51 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 30 12:45:56 volumio volumio[945]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.699&uuid=7fb2d7be377eded36e0afd52b6b9ba16" http://updates.volumio.org:7070/downloader-v1/track-device Apr 30 12:45:56 volumio volumio[945]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 12:45:56 volumio volumio[945]: Dload Upload Total Spent Left Speed Apr 30 12:45:56 volumio volumio[945]: [314B blob data] Apr 30 12:45:56 volumio volumio[945]: retrying in 5 seconds, trial 1 Apr 30 12:45:56 volumio volumio[945]: Volumio Calling Home Apr 30 12:45:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 30 12:45:58 volumio volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 30 12:46:10 volumio volumio[945]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 12:46:10 volumio volumio[945]: { Error: connect ETIMEDOUT 128.242.240.59:443 Apr 30 12:46:10 volumio volumio[945]: at Object._errnoException (util.js:1022:11) Apr 30 12:46:10 volumio volumio[945]: at _exceptionWithHostPort (util.js:1044:20) Apr 30 12:46:10 volumio volumio[945]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 30 12:46:10 volumio volumio[945]: code: 'ETIMEDOUT', Apr 30 12:46:10 volumio volumio[945]: errno: 'ETIMEDOUT', Apr 30 12:46:10 volumio volumio[945]: syscall: 'connect', Apr 30 12:46:10 volumio volumio[945]: address: '128.242.240.59', Apr 30 12:46:10 volumio volumio[945]: port: 443 } Apr 30 12:46:10 volumio volumio[945]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 12:46:10 volumio sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-30 12:45 Apr 30 12:46:10 volumio sudo[1422]: 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="e32e25d68d93383fe73e2a451c032b2661c71694" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jan 20 19:41:22 CET 2020" VOLUMIO_VERSION="2.699" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5faefe8928fcf34b6263aec4aa82825a"