-- Logs begin at Thu 2026-01-08 04:55:33 UTC, end at Mon 2026-06-01 10:17:51 UTC. -- Jun 01 10:16:01 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 10:16:01 opera volumio[10173]: info: CURURI: albums://%E7%B6%BE%E6%88%B8%E6%99%BA%E7%B5%B5/natural Jun 01 10:16:02 opera volumio[1648]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::ClearQueue Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::stop Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::serviceStop Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::serviceStop Jun 01 10:16:02 opera volumio[10173]: info: Airplay Stop Jun 01 10:16:02 opera volumio[10173]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::clearPlayQueue Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::saveQueue Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushQueue Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::addQueueItems Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::addQueueItems Jun 01 10:16:02 opera volumio[10173]: info: Adding Item to queue: albums://%E7%B6%BE%E6%88%B8%E6%99%BA%E7%B5%B5/natural Jun 01 10:16:02 opera volumio[10173]: info: Exploding uri albums://%E7%B6%BE%E6%88%B8%E6%99%BA%E7%B5%B5/natural in service mpd Jun 01 10:16:02 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:16:02 opera sudo[10835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 10395 Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::saveQueue Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushQueue Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::updateTrackBlock Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrackBlock Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPlay Jun 01 10:16:02 opera volumio[10173]: verbose: UNSET VOLATILE Jun 01 10:16:02 opera volumio[10173]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jun 01 10:16:02 opera sudo[10835]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 10:16:02 opera sudo[10835]: pam_unix(sudo:session): session closed for user root Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::play index 0 Jun 01 10:16:02 opera systemd[1]: shairport-sync.service: main process exited, code=killed, status=12/USR2 Jun 01 10:16:02 opera shairport-sync[10395]: {"time":1780308892690,"response":"airplayActive Success"} Jun 01 10:16:02 opera systemd[1]: Unit shairport-sync.service entered failed state. Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::stop Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:16:02 opera volumio[10173]: verbose: UNSET VOLATILE Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::stPlaybackTimer Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::updateTrackBlock Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrackBlock Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::serviceStop Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::serviceStop Jun 01 10:16:02 opera volumio[10173]: info: ControllerMpd::stop Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand stop took 14 milliseconds Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::play index undefined Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::startPlaybackTimer Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/綾戸智絵-natural/Woman Of Ireland(MNa Na h-EIREANN).flac Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 10:16:02 opera sudo[10846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 Jun 01 10:16:02 opera sudo[10846]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 10:16:02 opera sudo[10846]: pam_unix(sudo:session): session closed for user root Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand stop took 15 milliseconds Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand clear Jun 01 10:16:02 opera volumio[10173]: info: Shairport-Sync paused with USR2 Jun 01 10:16:02 opera volumio[10173]: info: Jun 01 10:16:02 opera volumio[10173]: ---------------------------- MPD announces system playlist update Jun 01 10:16:02 opera volumio[10173]: info: Ignoring MPD Status Update Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand clear took 9 milliseconds Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/綾戸智絵-natural/Woman Of Ireland(MNa Na h-EIREANN).flac" Jun 01 10:16:02 opera volumio[10173]: error: updateQueue error: null Jun 01 10:16:02 opera volumio[10173]: info: Jun 01 10:16:02 opera volumio[10173]: ---------------------------- MPD announces system playlist update Jun 01 10:16:02 opera volumio[10173]: info: Ignoring MPD Status Update Jun 01 10:16:02 opera volumio[10173]: info: ------------------------------ 10ms Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand add "INTERNAL/綾戸智絵-natural/Woman Of Ireland(MNa Na h-EIREANN).flac" took 7 milliseconds Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand play Jun 01 10:16:02 opera volumio[10173]: info: Cannot execute Shairport-sync USR2 kill: Error: Command failed: /usr/bin/sudo /bin/kill -USR2 $(pidof shairport-sync) Jun 01 10:16:02 opera volumio[10173]: kill: invalid argument U Jun 01 10:16:02 opera volumio[10173]: Usage: Jun 01 10:16:02 opera volumio[10173]: kill [options] [...] Jun 01 10:16:02 opera volumio[10173]: Options: Jun 01 10:16:02 opera volumio[10173]: [...] send signal to every listed Jun 01 10:16:02 opera volumio[10173]: -, -s, --signal Jun 01 10:16:02 opera volumio[10173]: specify the to be sent Jun 01 10:16:02 opera volumio[10173]: -l, --list=[] list all signal names, or convert one to a name Jun 01 10:16:02 opera volumio[10173]: -L, --table list all signal names in a nice table Jun 01 10:16:02 opera volumio[10173]: -h, --help display this help and exit Jun 01 10:16:02 opera volumio[10173]: -V, --version output version information and exit Jun 01 10:16:02 opera volumio[10173]: For more details see kill(1). Jun 01 10:16:02 opera volumio[10173]: info: ------------------------------ 7ms Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand play took 4 milliseconds Jun 01 10:16:02 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:16:02 opera volumio[10173]: info: Jun 01 10:16:02 opera volumio[10173]: ---------------------------- MPD announces state update: player Jun 01 10:16:02 opera volumio[10173]: info: ControllerMpd::getState Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand status Jun 01 10:16:02 opera volumio[10173]: info: Jun 01 10:16:02 opera volumio[10173]: ---------------------------- MPD announces state update: player Jun 01 10:16:02 opera volumio[10173]: info: ControllerMpd::getState Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand status Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand status took 2 milliseconds Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::parseState Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand status took 6 milliseconds Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::parseState Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::parseTrackInfo Jun 01 10:16:02 opera volumio[10173]: info: ControllerMpd::pushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"511 Kbps","isStreaming":false,"title":"Woman Of Ireland(MNa Na h-EIREANN)","artist":"綾戸智絵","album":"natural","uri":"INTERNAL/綾戸智絵-natural/Woman Of Ireland(MNa Na h-EIREANN).flac","trackType":"flac"} Jun 01 10:16:02 opera volumio[10173]: verbose: CURRENT POSITION 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::syncState stateService play Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::syncState currentStatus stop Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:16:02 opera volumio[10173]: info: ------------------------------ 27ms Jun 01 10:16:02 opera volumio[10173]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 01 10:16:02 opera volumio[10173]: verbose: ControllerMpd::parseTrackInfo Jun 01 10:16:02 opera volumio[10173]: info: ControllerMpd::pushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"511 Kbps","isStreaming":false,"title":"Woman Of Ireland(MNa Na h-EIREANN)","artist":"綾戸智絵","album":"natural","uri":"INTERNAL/綾戸智絵-natural/Woman Of Ireland(MNa Na h-EIREANN).flac","trackType":"flac"} Jun 01 10:16:02 opera volumio[10173]: verbose: CURRENT POSITION 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::syncState stateService play Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::syncState currentStatus play Jun 01 10:16:02 opera volumio[10173]: info: Received an update from plugin. extracting info from payload Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:16:02 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:16:02 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:16:02 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:16:02 opera volumio[10173]: info: ------------------------------ 44ms Jun 01 10:16:02 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:16:02 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:16:02 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:16:03 opera volumio[1648]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 01 10:16:03 opera volumio[10173]: info: Restarting Shairport-Sync after stop Jun 01 10:16:03 opera sudo[10858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 01 10:16:03 opera sudo[10858]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 10:16:03 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jun 01 10:16:03 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 01 10:16:03 opera sudo[10858]: pam_unix(sudo:session): session closed for user root Jun 01 10:16:03 opera volumio[10173]: info: Shairport-Sync retarted Jun 01 10:17:08 opera volumio[10173]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hirundo%20Maris/The%20Wind%20Rose/89ad4306-7abf-4e98-9ffd-8cbbd354699b.jpg' Jun 01 10:17:08 opera volumio[10173]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Apollo%20Chamber%20Players/Ancestral%20Voices/2b982029-db8a-44b4-bf6f-cb72df82e2fc.jpg' Jun 01 10:17:08 opera volumio[10173]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Masako%20Ezaki/Chopin%20Nocturnes/23cf2964-ae7a-40a6-8bd1-4d3a12c29fc1.jpg' Jun 01 10:17:10 opera volumio[10173]: info: CoreCommandRouter::volumioGetVisibleSources Jun 01 10:17:10 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 10:17:10 opera volumio[10173]: info: CoreCommandRouter::volumioGetState Jun 01 10:17:10 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:10 opera volumio[10173]: info: CoreCommandRouter::volumioGetQueue Jun 01 10:17:10 opera volumio[10173]: info: CoreStateMachine::getQueue Jun 01 10:17:10 opera volumio[10173]: info: CorePlayQueue::getQueue Jun 01 10:17:10 opera volumio[10173]: info: Listing playlists Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received airplay_emulation Jun 01 10:17:15 opera shairport-sync[10863]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 01 10:17:15 opera shairport-sync[10863]: Dload Upload Total Spent Left Speed Jun 01 10:17:15 opera shairport-sync[10863]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory Jun 01 10:17:15 opera shairport-sync[10863]: alsa: error -16 ("Device or resource busy") opening alsa device "plughw:5,0". Jun 01 10:17:15 opera volumio[10173]: info: Jun 01 10:17:15 opera volumio[10173]: ---------------------------- Client requests AirplayActive Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Jun 01 10:17:15 opera shairport-sync[10863]: 100 57 100 57 0 0 4885 0 --:--:-- --:--:-- --:--:-- 5181 Jun 01 10:17:15 opera volumio[10173]: info: Airplay started streaming, receiving metadatas Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioStop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::stop Jun 01 10:17:15 opera shairport-sync[10863]: {"time":1780309035690,"response":"airplayActive Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jun 01 10:17:15 opera shairport-sync[10863]: Dload Upload Total Spent Left Speed Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:17:15 opera volumio[10173]: verbose: UNSET VOLATILE Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::stPlaybackTimer Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::updateTrackBlock Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrackBlock Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::serviceStop Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::serviceStop Jun 01 10:17:15 opera volumio[10173]: info: ControllerMpd::stop Jun 01 10:17:15 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:17:15 opera volumio[10173]: info: Airplay started streaming, receiving metadatas Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioStop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::stop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:17:15 opera volumio[10173]: verbose: UNSET VOLATILE Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:17:15 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:15 opera volumio[10173]: info: Jun 01 10:17:15 opera volumio[10173]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jun 01 10:17:15 opera volumio[10173]: info: Airplay playback start Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioStop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::stop Jun 01 10:17:15 opera shairport-sync[10863]: [155B blob data] Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:17:15 opera volumio[10173]: verbose: UNSET VOLATILE Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 10:17:15 opera shairport-sync[10863]: alsa: error -16 ("Device or resource busy") opening alsa device "plughw:5,0". Jun 01 10:17:15 opera shairport-sync[10863]: alsa: error -16 ("Device or resource busy") opening alsa device "plughw:5,0". Jun 01 10:17:15 opera volumio[10173]: info: Jun 01 10:17:15 opera volumio[10173]: ---------------------------- MPD announces state update: player Jun 01 10:17:15 opera volumio[10173]: info: sendMpdCommand stop took 62 milliseconds Jun 01 10:17:15 opera volumio[10173]: info: ControllerMpd::getState Jun 01 10:17:15 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand status Jun 01 10:17:15 opera volumio[10173]: info: sendMpdCommand status took 1 milliseconds Jun 01 10:17:15 opera volumio[10173]: verbose: ControllerMpd::parseState Jun 01 10:17:15 opera volumio[10173]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 10:17:15 opera volumio[10173]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 01 10:17:15 opera volumio[10173]: verbose: ControllerMpd::parseTrackInfo Jun 01 10:17:15 opera volumio[10173]: info: ControllerMpd::pushState Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Woman Of Ireland(MNa Na h-EIREANN)","artist":"綾戸智絵","album":"natural","uri":"INTERNAL/綾戸智絵-natural/Woman Of Ireland(MNa Na h-EIREANN).flac","trackType":"flac"} Jun 01 10:17:15 opera volumio[10173]: verbose: CURRENT POSITION 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::syncState stateService stop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::syncState currentStatus stop Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:15 opera volumio[10173]: info: No code Jun 01 10:17:15 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:15 opera volumio[10173]: info: CorePlayQueue::getTrack 0 Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:15 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:15 opera volumio[10173]: info: ------------------------------ 25ms Jun 01 10:17:15 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:15 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:15 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:16 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:16 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:16 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:16 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:16 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:16 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:16 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:17 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:17 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:17 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:17 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:17 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:17 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:17 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:17 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:17 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:27 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:27 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:27 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:27 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:27 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:27 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:27 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:27 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:27 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:47 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:47 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:47 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:47 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:47 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:47 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:47 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:47 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:47 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:47 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:47 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:47 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:47 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:48 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:48 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:48 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:49 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:49 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:49 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:49 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:49 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:49 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:49 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:49 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:49 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:49 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:50 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:50 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:50 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:50 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:50 opera volumio[10173]: info: CoreCommandRouter::servicePushState Jun 01 10:17:50 opera volumio[10173]: info: CoreStateMachine::pushState Jun 01 10:17:50 opera volumio[10173]: info: CoreCommandRouter::volumioPushState Jun 01 10:17:50 opera volumio[10173]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 10:17:50 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:50 opera volumio[10173]: info: Updating RAAT Signal Path Jun 01 10:17:51 opera volumio[10173]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 10:17:51 opera volumio[10173]: { Error: connect ETIMEDOUT 103.97.3.19:443 Jun 01 10:17:51 opera volumio[10173]: at Object._errnoException (util.js:1022:11) Jun 01 10:17:51 opera volumio[10173]: at _exceptionWithHostPort (util.js:1044:20) Jun 01 10:17:51 opera volumio[10173]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 01 10:17:51 opera volumio[10173]: code: 'ETIMEDOUT', Jun 01 10:17:51 opera volumio[10173]: errno: 'ETIMEDOUT', Jun 01 10:17:51 opera volumio[10173]: syscall: 'connect', Jun 01 10:17:51 opera volumio[10173]: address: '103.97.3.19', Jun 01 10:17:51 opera volumio[10173]: port: 443 } Jun 01 10:17:51 opera volumio[10173]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 10:17:51 opera sudo[11159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-01 10:16 Jun 01 10:17:51 opera sudo[11159]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"