-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2025-01-20 10:24:00 CET. -- Jan 20 10:22:08 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 20 10:22:08 volumio volumio[740]: info: CURURI: playlists/Principal Jan 20 10:22:08 volumio volumio[740]: info: Preload queue cleared Jan 20 10:22:08 volumio volumio[740]: info: Preloading song: http://ouifm.ice.infomaniak.ch/ouifm-high.mp3 Jan 20 10:22:08 volumio volumio[740]: info: Preloading song: http://ouifm2.ice.infomaniak.ch/ouifm2.mp3 Jan 20 10:22:08 volumio volumio[740]: info: Preloading song: http://ouifm3.ice.infomaniak.ch/ouifm3.mp3 Jan 20 10:22:08 volumio volumio[740]: info: Preloading song: http://ouifmrock80s.ice.infomaniak.ch/ouifmeighties.mp3 Jan 20 10:22:08 volumio volumio[740]: info: Preloading song: https://scdn.nrjaudio.fm/adwz1/fr/30627/mp3_128.mp3?origine=tune-in-radio Jan 20 10:22:08 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 20 10:22:08 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 20 10:22:08 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 20 10:22:08 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 20 10:22:08 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 20 10:22:17 volumio volumio[740]: info: CoreCommandRouter::volumioGetState Jan 20 10:22:17 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:22:20 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 20 10:22:20 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 20 10:22:24 volumio volumio[740]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 10:22:40 volumio volumio[740]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Jan 20 10:22:40 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Jan 20 10:22:40 volumio sudo[6542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:40 volumio sudo[6542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:40 volumio sudo[6542]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:40 volumio sudo[6545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 Jan 20 10:22:40 volumio sudo[6545]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:40 volumio kernel: input: button@11 as /devices/platform/button@11/input/input10 Jan 20 10:22:40 volumio sudo[6545]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:40 volumio sudo[6558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:40 volumio sudo[6558]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:40 volumio sudo[6558]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:41 volumio sudo[6561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:41 volumio sudo[6561]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:41 volumio sudo[6561]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:41 volumio sudo[6565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 Jan 20 10:22:41 volumio sudo[6565]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:41 volumio systemd-udevd[6551]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 10:22:41 volumio sudo[6565]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:42 volumio sudo[6574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:42 volumio sudo[6574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:42 volumio sudo[6574]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:42 volumio sudo[6577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:42 volumio sudo[6577]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:42 volumio sudo[6577]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:43 volumio sudo[6580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 20 10:22:43 volumio sudo[6580]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:43 volumio kernel: input: button@1a as /devices/platform/button@1a/input/input11 Jan 20 10:22:43 volumio sudo[6580]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:43 volumio sudo[6590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:43 volumio sudo[6590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:43 volumio sudo[6590]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:43 volumio sudo[6593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:43 volumio sudo[6593]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:43 volumio sudo[6593]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:43 volumio sudo[6597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 20 10:22:43 volumio sudo[6597]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:43 volumio systemd-udevd[6551]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 10:22:43 volumio systemd-logind[409]: Failed to open /dev/input/event0: No such device Jan 20 10:22:43 volumio sudo[6597]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:43 volumio sudo[6606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:43 volumio sudo[6606]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:43 volumio sudo[6606]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:45 volumio sudo[6609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=6 pin_b=5 relative_axis=true steps-per-period=1 Jan 20 10:22:45 volumio sudo[6609]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:45 volumio kernel: rotary-encoder rotary@6: gray Jan 20 10:22:45 volumio kernel: input: rotary@6 as /devices/platform/rotary@6/input/input12 Jan 20 10:22:45 volumio sudo[6609]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:45 volumio systemd-udevd[6551]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 10:22:47 volumio sudo[6622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=26 active_low=1 gpio_pull=up keycode=20 Jan 20 10:22:47 volumio sudo[6622]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:47 volumio kernel: input: button@1a as /devices/platform/button@1a/input/input13 Jan 20 10:22:47 volumio sudo[6622]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:48 volumio systemd-udevd[6551]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 10:22:50 volumio sudo[6633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=22 pin_b=27 relative_axis=true steps-per-period=1 Jan 20 10:22:50 volumio sudo[6633]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:50 volumio kernel: rotary-encoder rotary@16: gray Jan 20 10:22:50 volumio kernel: input: rotary@16 as /devices/platform/rotary@16/input/input14 Jan 20 10:22:50 volumio sudo[6633]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:50 volumio systemd-udevd[6551]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 10:22:52 volumio sudo[6646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=17 active_low=1 gpio_pull=up keycode=20 Jan 20 10:22:52 volumio sudo[6646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:52 volumio kernel: input: button@11 as /devices/platform/button@11/input/input15 Jan 20 10:22:52 volumio sudo[6646]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:53 volumio systemd-udevd[6551]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 10:22:55 volumio sudo[6658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:55 volumio sudo[6658]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:55 volumio sudo[6658]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:55 volumio sudo[6662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:55 volumio sudo[6662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:55 volumio sudo[6662]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:55 volumio sudo[6666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:55 volumio sudo[6666]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:55 volumio sudo[6666]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:55 volumio sudo[6670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 10:22:55 volumio sudo[6670]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 10:22:55 volumio sudo[6670]: pam_unix(sudo:session): session closed for user root Jan 20 10:22:59 volumio volumio[740]: info: CoreCommandRouter::volumioGetState Jan 20 10:22:59 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:44 volumio volumio[740]: info: CoreCommandRouter::volumioPlay Jan 20 10:23:44 volumio volumio[740]: info: CoreStateMachine::play index undefined Jan 20 10:23:44 volumio volumio[740]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 10:23:44 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:44 volumio volumio[740]: info: CoreStateMachine::startPlaybackTimer Jan 20 10:23:44 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:44 volumio volumio[740]: info: [1737365024994] ControllerWebradio::clearAddPlayTrack Jan 20 10:23:44 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 10:23:45 volumio volumio[740]: info: sendMpdCommand stop took 30 milliseconds Jan 20 10:23:45 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 10:23:45 volumio volumio[740]: info: sendMpdCommand clear took 3 milliseconds Jan 20 10:23:45 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand load "http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn" Jan 20 10:23:45 volumio volumio[740]: info: Jan 20 10:23:45 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jan 20 10:23:45 volumio volumio[740]: info: Ignoring MPD Status Update Jan 20 10:23:45 volumio volumio[740]: info: Jan 20 10:23:45 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jan 20 10:23:45 volumio volumio[740]: info: Ignoring MPD Status Update Jan 20 10:23:45 volumio volumio[740]: error: Upnp client error: Error: This socket has been ended by the other party Jan 20 10:23:46 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand add "http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn" Jan 20 10:23:46 volumio volumio[740]: error: updateQueue error: null Jan 20 10:23:46 volumio volumio[740]: error: updateQueue error: null Jan 20 10:23:46 volumio volumio[740]: info: Jan 20 10:23:46 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jan 20 10:23:46 volumio volumio[740]: info: Ignoring MPD Status Update Jan 20 10:23:46 volumio volumio[740]: info: ------------------------------ 1713ms Jan 20 10:23:46 volumio volumio[740]: info: ------------------------------ 1691ms Jan 20 10:23:46 volumio volumio[740]: info: sendMpdCommand add "http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn" took 11 milliseconds Jan 20 10:23:46 volumio volumio[740]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 20 10:23:46 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand play Jan 20 10:23:46 volumio volumio[740]: info: Jan 20 10:23:46 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jan 20 10:23:46 volumio volumio[740]: info: Ignoring MPD Status Update Jan 20 10:23:46 volumio volumio[740]: info: ------------------------------ 15ms Jan 20 10:23:46 volumio volumio[740]: info: sendMpdCommand play took 9 milliseconds Jan 20 10:23:46 volumio volumio[740]: info: ------------------------------ 8ms Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces state update: player Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::getState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces state update: player Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::getState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - ---- read samplerate from file: 48000 Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 10:23:48 volumio kernel: voicehat-codec voicehat-codec: Enabling audio amp... Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - ---- read samplerate from file: 48000 Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces state update: player Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jan 20 10:23:48 volumio volumio[740]: info: Ignoring MPD Status Update Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces state update: player Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand status took 126 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::getState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand status took 124 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::getState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces state update: player Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::getState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand status took 23 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 30ms Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand status took 22 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand playlistinfo took 18 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand status took 10 milliseconds Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","artist":"Europe1","album":null,"uri":"http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","trackType":""} Jan 20 10:23:48 volumio volumio[740]: verbose: CURRENT POSITION 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus stop Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","artist":"Europe1","album":null,"uri":"http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","trackType":""} Jan 20 10:23:48 volumio volumio[740]: verbose: CURRENT POSITION 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus play Jan 20 10:23:48 volumio volumio[740]: info: Received an update from plugin. extracting info from payload Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 212ms Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 219ms Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces system playlist update Jan 20 10:23:48 volumio volumio[740]: info: Ignoring MPD Status Update Jan 20 10:23:48 volumio volumio[740]: info: Jan 20 10:23:48 volumio volumio[740]: ---------------------------- MPD announces state update: player Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::getState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand status Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand playlistinfo took 76 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand playlistinfo took 75 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand playlistinfo took 69 milliseconds Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 13ms Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand status took 9 milliseconds Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseState Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","artist":"Europe1","album":null,"uri":"http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","trackType":""} Jan 20 10:23:48 volumio volumio[740]: verbose: CURRENT POSITION 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus play Jan 20 10:23:48 volumio volumio[740]: info: Received an update from plugin. extracting info from payload Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","artist":"Europe1","album":null,"uri":"http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","trackType":""} Jan 20 10:23:48 volumio volumio[740]: verbose: CURRENT POSITION 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus play Jan 20 10:23:48 volumio volumio[740]: info: Received an update from plugin. extracting info from payload Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","artist":"Europe1","album":null,"uri":"http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","trackType":""} Jan 20 10:23:48 volumio volumio[740]: verbose: CURRENT POSITION 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus play Jan 20 10:23:48 volumio volumio[740]: info: Received an update from plugin. extracting info from payload Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 213ms Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 212ms Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 196ms Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Handling event: musicPlay Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: sendMpdCommand playlistinfo took 202 milliseconds Jan 20 10:23:48 volumio volumio[740]: verbose: ControllerMpd::parseTrackInfo Jan 20 10:23:48 volumio volumio[740]: info: ControllerMpd::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::servicePushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1732,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","artist":"Europe1","album":null,"uri":"http://stream.europe1.fr/europe1.mp3?aw_0_1st.playerid=lgrdrnwsTuneIn","trackType":""} Jan 20 10:23:48 volumio volumio[740]: verbose: CURRENT POSITION 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState stateService play Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::syncState currentStatus play Jan 20 10:23:48 volumio volumio[740]: info: Received an update from plugin. extracting info from payload Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CorePlayQueue::getTrack 0 Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: CoreStateMachine::pushState Jan 20 10:23:48 volumio volumio[740]: info: CoreCommandRouter::volumioPushState Jan 20 10:23:48 volumio volumio[740]: info: ------------------------------ 260ms Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 10:23:48 volumio volumio[740]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:48 volumio volumio[740]: info: [GPIO_Control] Status changed: play Jan 20 10:23:58 volumio volumio[740]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 10:23:58 volumio volumio[740]: SyntaxError: Unexpected token ‘ in JSON at position 1 Jan 20 10:23:58 volumio volumio[740]: at JSON.parse () Jan 20 10:23:58 volumio volumio[740]: at rotaryencoder2.emitPushCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:1048:17) Jan 20 10:23:58 volumio volumio[740]: at Timeout._onTimeout (/data/plugins/system_hardware/rotaryencoder2/index.js:908:16) Jan 20 10:23:58 volumio volumio[740]: at listOnTimeout (internal/timers.js:554:17) Jan 20 10:23:58 volumio volumio[740]: at processTimers (internal/timers.js:497:7) Jan 20 10:23:58 volumio volumio[740]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 10:24:00 volumio sudo[6715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 10:22 Jan 20 10:24:00 volumio sudo[6715]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"