-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Mon 2025-01-20 17:51:51 CET. -- Jan 20 17:50:00 volumio4 sudo[24646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:00 volumio4 sudo[24646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 sudo[24646]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 Jan 20 17:50:00 volumio4 sudo[24649]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 kernel: input: button@17 as /devices/platform/button@17/input/input58 Jan 20 17:50:00 volumio4 sudo[24649]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:00 volumio4 sudo[24662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 sudo[24662]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:00 volumio4 sudo[24665]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 sudo[24665]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 Jan 20 17:50:00 volumio4 sudo[24668]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 systemd-udevd[24655]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:00 volumio4 systemd-logind[708]: Failed to open /dev/input/event7: No such device Jan 20 17:50:00 volumio4 sudo[24668]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:00 volumio4 sudo[24679]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 sudo[24679]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:00 volumio4 sudo[24682]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 sudo[24682]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 20 17:50:00 volumio4 sudo[24685]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 kernel: input: button@11 as /devices/platform/button@11/input/input59 Jan 20 17:50:00 volumio4 sudo[24685]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:00 volumio4 sudo[24695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:00 volumio4 sudo[24695]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:00 volumio4 sudo[24695]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:01 volumio4 sudo[24698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:01 volumio4 sudo[24698]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:01 volumio4 sudo[24698]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:01 volumio4 sudo[24701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 20 17:50:01 volumio4 sudo[24701]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:01 volumio4 systemd-udevd[24655]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:01 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 17:50:01 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 17:50:01 volumio4 volumio[22460]: info: Discovery: Getting this device information Jan 20 17:50:01 volumio4 volumio[22460]: info: CoreCommandRouter::volumioGetState Jan 20 17:50:01 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:50:01 volumio4 systemd-logind[708]: Failed to open /dev/input/event5: No such device Jan 20 17:50:01 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 20 17:50:01 volumio4 sudo[24701]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:01 volumio4 sudo[24712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:01 volumio4 sudo[24712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:01 volumio4 sudo[24712]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:01 volumio4 sudo[24715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=22 pin_b=27 relative_axis=true steps-per-period=2 Jan 20 17:50:01 volumio4 sudo[24715]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:01 volumio4 kernel: rotary-encoder rotary@16: gray Jan 20 17:50:01 volumio4 kernel: input: rotary@16 as /devices/platform/rotary@16/input/input60 Jan 20 17:50:01 volumio4 sudo[24715]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:01 volumio4 systemd-udevd[24655]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:02 volumio4 sudo[24728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=17 active_low=1 gpio_pull=up keycode=20 Jan 20 17:50:02 volumio4 sudo[24728]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:02 volumio4 kernel: input: button@11 as /devices/platform/button@11/input/input61 Jan 20 17:50:02 volumio4 sudo[24728]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:02 volumio4 systemd-udevd[24655]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:03 volumio4 sudo[24755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=18 pin_b=24 relative_axis=true steps-per-period=2 Jan 20 17:50:03 volumio4 sudo[24755]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:03 volumio4 kernel: rotary-encoder rotary@12: gray Jan 20 17:50:03 volumio4 kernel: input: rotary@12 as /devices/platform/rotary@12/input/input62 Jan 20 17:50:03 volumio4 sudo[24755]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:03 volumio4 systemd-udevd[24655]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:04 volumio4 sudo[24768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=23 active_low=1 gpio_pull=up keycode=20 Jan 20 17:50:04 volumio4 sudo[24768]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:04 volumio4 kernel: input: button@17 as /devices/platform/button@17/input/input63 Jan 20 17:50:04 volumio4 sudo[24768]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:04 volumio4 systemd-udevd[24655]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:05 volumio4 sudo[24780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:05 volumio4 sudo[24780]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:05 volumio4 sudo[24780]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:05 volumio4 sudo[24784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:05 volumio4 sudo[24784]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:05 volumio4 sudo[24784]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:05 volumio4 sudo[24788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:05 volumio4 sudo[24788]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:05 volumio4 sudo[24788]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:05 volumio4 sudo[24792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:05 volumio4 sudo[24792]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:05 volumio4 sudo[24792]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 17:50:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 17:50:31 volumio4 volumio[22460]: info: Discovery: Getting this device information Jan 20 17:50:31 volumio4 volumio[22460]: info: CoreCommandRouter::volumioGetState Jan 20 17:50:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:50:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 20 17:50:47 volumio4 volumio[22460]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Jan 20 17:50:47 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Jan 20 17:50:47 volumio4 sudo[24913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:47 volumio4 sudo[24913]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:47 volumio4 sudo[24913]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:47 volumio4 sudo[24916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 Jan 20 17:50:47 volumio4 sudo[24916]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:47 volumio4 kernel: input: button@17 as /devices/platform/button@17/input/input64 Jan 20 17:50:47 volumio4 sudo[24916]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:47 volumio4 sudo[24930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:47 volumio4 sudo[24930]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:47 volumio4 sudo[24930]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:48 volumio4 sudo[24933]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 sudo[24933]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 2 Jan 20 17:50:48 volumio4 sudo[24936]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 systemd-udevd[24921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:48 volumio4 systemd-logind[708]: Failed to open /dev/input/event7: No such device Jan 20 17:50:48 volumio4 sudo[24936]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:48 volumio4 sudo[24947]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 sudo[24947]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:48 volumio4 sudo[24950]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 sudo[24950]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 20 17:50:48 volumio4 sudo[24953]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 kernel: input: button@11 as /devices/platform/button@11/input/input65 Jan 20 17:50:48 volumio4 sudo[24953]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:48 volumio4 sudo[24964]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 sudo[24964]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:48 volumio4 sudo[24967]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 sudo[24967]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Jan 20 17:50:48 volumio4 sudo[24970]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 systemd-udevd[24921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:48 volumio4 startx[4033]: (EE) client bug: Invalid path /dev/input/event5 Jan 20 17:50:48 volumio4 systemd-logind[708]: Failed to open /dev/input/event5: No such file or directory Jan 20 17:50:48 volumio4 sudo[24970]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:48 volumio4 sudo[24981]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 sudo[24981]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:48 volumio4 sudo[24984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=22 pin_b=27 relative_axis=true steps-per-period=2 Jan 20 17:50:48 volumio4 sudo[24984]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:48 volumio4 kernel: rotary-encoder rotary@16: gray Jan 20 17:50:48 volumio4 kernel: input: rotary@16 as /devices/platform/rotary@16/input/input66 Jan 20 17:50:48 volumio4 sudo[24984]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:49 volumio4 systemd-udevd[24921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:49 volumio4 sudo[24997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=17 active_low=1 gpio_pull=up keycode=20 Jan 20 17:50:49 volumio4 sudo[24997]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:50 volumio4 kernel: input: button@11 as /devices/platform/button@11/input/input67 Jan 20 17:50:50 volumio4 sudo[24997]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:50 volumio4 systemd-udevd[24921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:51 volumio4 sudo[25009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=18 pin_b=24 relative_axis=true steps-per-period=2 Jan 20 17:50:51 volumio4 sudo[25009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:51 volumio4 kernel: rotary-encoder rotary@12: gray Jan 20 17:50:51 volumio4 kernel: input: rotary@12 as /devices/platform/rotary@12/input/input68 Jan 20 17:50:51 volumio4 sudo[25009]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:51 volumio4 systemd-udevd[24921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:52 volumio4 sudo[25022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=23 active_low=1 gpio_pull=up keycode=20 Jan 20 17:50:52 volumio4 sudo[25022]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:52 volumio4 kernel: input: button@17 as /devices/platform/button@17/input/input69 Jan 20 17:50:52 volumio4 sudo[25022]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:52 volumio4 systemd-udevd[24921]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 17:50:53 volumio4 sudo[25035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:53 volumio4 sudo[25035]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:53 volumio4 sudo[25035]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:53 volumio4 sudo[25039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:53 volumio4 sudo[25039]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:53 volumio4 sudo[25039]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:53 volumio4 sudo[25057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:53 volumio4 sudo[25057]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:53 volumio4 sudo[25057]: pam_unix(sudo:session): session closed for user root Jan 20 17:50:53 volumio4 sudo[25061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 20 17:50:53 volumio4 sudo[25061]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 17:50:53 volumio4 sudo[25061]: pam_unix(sudo:session): session closed for user root Jan 20 17:51:01 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 17:51:01 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 17:51:01 volumio4 volumio[22460]: info: Discovery: Getting this device information Jan 20 17:51:01 volumio4 volumio[22460]: info: CoreCommandRouter::volumioGetState Jan 20 17:51:01 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:01 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPlay Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:08 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:08 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3 Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand stop took 2 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:08 volumio4 volumio[22460]: info: Jan 20 17:51:08 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:08 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand clear took 2 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3" Jan 20 17:51:08 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:08 volumio4 volumio[22460]: info: ------------------------------ 4ms Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3" took 2 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:08 volumio4 volumio[22460]: info: Jan 20 17:51:08 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:08 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand play took 2 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: info: ------------------------------ 2ms Jan 20 17:51:08 volumio4 volumio[22460]: info: Jan 20 17:51:08 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:08 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:08 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: Jan 20 17:51:08 volumio4 volumio[22460]: error: FusionDsp - invalid sample rate Jan 20 17:51:08 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:08 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:08 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:08 volumio4 volumio[22460]: info: Jan 20 17:51:08 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand status took 35 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand status took 3 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:08 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:08 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:08 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Real Life","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3","trackType":"mp3"} Jan 20 17:51:08 volumio4 volumio[22460]: verbose: CURRENT POSITION 0 Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:08 volumio4 volumio[22460]: info: ------------------------------ 46ms Jan 20 17:51:08 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 20 17:51:08 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:08 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:08 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:08 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Real Life","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3","trackType":"mp3"} Jan 20 17:51:08 volumio4 volumio[22460]: verbose: CURRENT POSITION 0 Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:08 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:08 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:08 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:08 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:08 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:08 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:08 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:08 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:08 volumio4 volumio[22460]: info: ------------------------------ 88ms Jan 20 17:51:08 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:08 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPrevious Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreStateMachine::previous Jan 20 17:51:17 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:17 volumio4 volumio[22460]: info: ControllerMpd::seek Jan 20 17:51:17 volumio4 volumio[22460]: error: null Jan 20 17:51:17 volumio4 volumio[22460]: info: Jan 20 17:51:17 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:17 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:17 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:17 volumio4 volumio[22460]: info: sendMpdCommand status took 1 milliseconds Jan 20 17:51:17 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:17 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:17 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 17:51:17 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:17 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:17 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:17 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Real Life","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3","trackType":"mp3"} Jan 20 17:51:17 volumio4 volumio[22460]: verbose: CURRENT POSITION 0 Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:17 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:17 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:17 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:17 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:17 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:17 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:17 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:17 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:17 volumio4 volumio[22460]: info: ------------------------------ 72ms Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreCommandRouter::volumioNext Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::next Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:19 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:19 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:19 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:19 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreStateMachine::serviceStop Jan 20 17:51:19 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 0 Jan 20 17:51:19 volumio4 volumio[22460]: info: CoreCommandRouter::serviceStop Jan 20 17:51:19 volumio4 volumio[22460]: info: ControllerMpd::stop Jan 20 17:51:19 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:19 volumio4 volumio[22460]: info: Jan 20 17:51:19 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand stop took 46 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/02. The Weeknd - Losers.mp3 Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand status took 40 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand stop took 36 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:20 volumio4 volumio[22460]: info: Jan 20 17:51:20 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:20 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand clear took 2 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/02. The Weeknd - Losers.mp3" Jan 20 17:51:20 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: 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":"Real Life","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/01. The Weeknd - Real Life.mp3","trackType":"mp3"} Jan 20 17:51:20 volumio4 volumio[22460]: verbose: CURRENT POSITION 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService stop Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:20 volumio4 volumio[22460]: info: No code Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:20 volumio4 volumio[22460]: info: ------------------------------ 145ms Jan 20 17:51:20 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:20 volumio4 volumio[22460]: info: Jan 20 17:51:20 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:20 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:20 volumio4 volumio[22460]: info: ------------------------------ 104ms Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/02. The Weeknd - Losers.mp3" took 103 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:20 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:20 volumio4 volumio[22460]: info: ------------------------------ 56ms Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand play took 54 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: info: Jan 20 17:51:20 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:20 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:20 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: Jan 20 17:51:20 volumio4 volumio[22460]: error: FusionDsp - invalid sample rate Jan 20 17:51:20 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:20 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:20 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:20 volumio4 volumio[22460]: info: Jan 20 17:51:20 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand status took 22 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:20 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand status took 7 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:20 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Losers","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/02. The Weeknd - Losers.mp3","trackType":"mp3"} Jan 20 17:51:20 volumio4 volumio[22460]: verbose: CURRENT POSITION 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:20 volumio4 volumio[22460]: info: ------------------------------ 44ms Jan 20 17:51:20 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 20 17:51:20 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:20 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":281,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Losers","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/02. The Weeknd - Losers.mp3","trackType":"mp3"} Jan 20 17:51:20 volumio4 volumio[22460]: verbose: CURRENT POSITION 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:20 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:20 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:20 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:20 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:20 volumio4 volumio[22460]: info: ------------------------------ 103ms Jan 20 17:51:20 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioNext Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::next Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::serviceStop Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 1 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::serviceStop Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::stop Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand stop took 38 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 2 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 2 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/03. The Weeknd - Tell Your Friends.mp3 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand status took 8 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand stop took 5 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:21 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 38 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand clear took 39 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/03. The Weeknd - Tell Your Friends.mp3" Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 2 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 2 Jan 20 17:51:21 volumio4 volumio[22460]: 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":"Losers","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/02. The Weeknd - Losers.mp3","trackType":"mp3"} Jan 20 17:51:21 volumio4 volumio[22460]: verbose: CURRENT POSITION 2 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 2 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: No code Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 2 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 144ms Jan 20 17:51:21 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:21 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 99ms Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/03. The Weeknd - Tell Your Friends.mp3" took 96 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:21 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 34ms Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand play took 31 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioNext Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::next Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 3 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 3 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/04. The Weeknd - Often.mp3 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand stop took 14 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:21 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand status took 4 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand clear took 8 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/04. The Weeknd - Often.mp3" Jan 20 17:51:21 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 8ms Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/04. The Weeknd - Often.mp3" took 2 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:21 volumio4 volumio[22460]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 16ms Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:21 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand play took 2 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 2ms Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand status took 17 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand status took 7 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 3 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Often","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/04. The Weeknd - Often.mp3","trackType":"mp3"} Jan 20 17:51:21 volumio4 volumio[22460]: verbose: CURRENT POSITION 3 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 34ms Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioNext Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::next Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 3 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::serviceStop Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 3 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::serviceStop Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::stop Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 60 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 3 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Often","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/04. The Weeknd - Often.mp3","trackType":"mp3"} Jan 20 17:51:21 volumio4 volumio[22460]: verbose: CURRENT POSITION 3 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 74ms Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand stop took 55 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand status took 3 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:21 volumio4 volumio[22460]: 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":"Often","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/04. The Weeknd - Often.mp3","trackType":"mp3"} Jan 20 17:51:21 volumio4 volumio[22460]: verbose: CURRENT POSITION 4 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService stop Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3 Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 84ms Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:21 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:21 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:21 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand stop took 37 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:21 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand clear took 85 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3" Jan 20 17:51:21 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:21 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 52ms Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3" took 51 milliseconds Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:21 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:21 volumio4 volumio[22460]: info: ------------------------------ 4ms Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand play took 3 milliseconds Jan 20 17:51:21 volumio4 kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Jan 20 17:51:21 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:21 volumio4 volumio[22460]: info: camilladsp spawned new process with pid 25131, instance 1, run: true Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:21 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:21 volumio4 volumio[22460]: info: Jan 20 17:51:21 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:21 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:21 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:21 volumio4 volumio[22460]: info: sendMpdCommand status took 8 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand status took 3 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:22 volumio4 volumio[22460]: error: FusionDsp - WebSocket error: [object Object] Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:22 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":349,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:22 volumio4 volumio[22460]: verbose: CURRENT POSITION 5 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:22 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":349,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:22 volumio4 volumio[22460]: verbose: CURRENT POSITION 5 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:22 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:22 volumio4 volumio[22460]: info: ------------------------------ 51ms Jan 20 17:51:22 volumio4 volumio[22460]: info: ------------------------------ 88ms Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioNext Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::next Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::serviceStop Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::serviceStop Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::stop Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:22 volumio4 volumio[22460]: info: Jan 20 17:51:22 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand stop took 152 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/07. The Weeknd - Can't Feel My Face.mp3 Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand status took 6 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand stop took 4 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:22 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:22 volumio4 volumio[22460]: info: Jan 20 17:51:22 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:22 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand clear took 12 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/07. The Weeknd - Can't Feel My Face.mp3" Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: 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":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:22 volumio4 volumio[22460]: verbose: CURRENT POSITION 6 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService stop Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:22 volumio4 volumio[22460]: info: No code Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:22 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:22 volumio4 volumio[22460]: info: ------------------------------ 156ms Jan 20 17:51:22 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:22 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:22 volumio4 volumio[22460]: info: Jan 20 17:51:22 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:22 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:22 volumio4 volumio[22460]: info: ------------------------------ 142ms Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/07. The Weeknd - Can't Feel My Face.mp3" took 141 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:22 volumio4 volumio[22460]: info: ------------------------------ 37ms Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand play took 36 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: info: camilladsp spawned new process with pid 25145, instance 1, run: true Jan 20 17:51:22 volumio4 volumio[22460]: info: Jan 20 17:51:22 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:22 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:22 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:22 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand status took 22 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:22 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 17:51:22 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:22 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:22 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:22 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":214,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Can't Feel My Face","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/07. The Weeknd - Can't Feel My Face.mp3","trackType":"mp3"} Jan 20 17:51:22 volumio4 volumio[22460]: verbose: CURRENT POSITION 6 Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:22 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:22 volumio4 volumio[22460]: info: ------------------------------ 33ms Jan 20 17:51:22 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPrevious Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreStateMachine::previous Jan 20 17:51:26 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:26 volumio4 volumio[22460]: info: ControllerMpd::seek Jan 20 17:51:26 volumio4 volumio[22460]: error: null Jan 20 17:51:26 volumio4 volumio[22460]: info: Jan 20 17:51:26 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:26 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:26 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:26 volumio4 volumio[22460]: info: sendMpdCommand status took 1 milliseconds Jan 20 17:51:26 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:26 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:26 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 20 17:51:26 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:26 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:26 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:26 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Can't Feel My Face","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/07. The Weeknd - Can't Feel My Face.mp3","trackType":"mp3"} Jan 20 17:51:26 volumio4 volumio[22460]: verbose: CURRENT POSITION 6 Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:26 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:26 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:26 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:26 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:26 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:26 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:26 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:26 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:26 volumio4 volumio[22460]: info: ------------------------------ 76ms Jan 20 17:51:26 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPrevious Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::previous Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::serviceStop Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::serviceStop Jan 20 17:51:28 volumio4 volumio[22460]: info: ControllerMpd::stop Jan 20 17:51:28 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:28 volumio4 volumio[22460]: info: Jan 20 17:51:28 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:28 volumio4 volumio[22460]: info: sendMpdCommand stop took 40 milliseconds Jan 20 17:51:28 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:28 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:28 volumio4 volumio[22460]: info: sendMpdCommand status took 2 milliseconds Jan 20 17:51:28 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:28 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:28 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 36 milliseconds Jan 20 17:51:28 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:28 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: 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":"Can't Feel My Face","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/07. The Weeknd - Can't Feel My Face.mp3","trackType":"mp3"} Jan 20 17:51:28 volumio4 volumio[22460]: verbose: CURRENT POSITION 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService stop Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:28 volumio4 volumio[22460]: info: No code Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:28 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 6 Jan 20 17:51:28 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:28 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:28 volumio4 volumio[22460]: info: ------------------------------ 125ms Jan 20 17:51:28 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:29 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:29 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3 Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand stop took 1 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:29 volumio4 volumio[22460]: info: Jan 20 17:51:29 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:29 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand clear took 1 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3" Jan 20 17:51:29 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:29 volumio4 volumio[22460]: info: ------------------------------ 2ms Jan 20 17:51:29 volumio4 volumio[22460]: info: Jan 20 17:51:29 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:29 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3" took 2 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:29 volumio4 volumio[22460]: info: ------------------------------ 2ms Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand play took 1 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: info: Jan 20 17:51:29 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:29 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:29 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:29 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:29 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:29 volumio4 volumio[22460]: info: Jan 20 17:51:29 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand status took 19 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand status took 2 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:29 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:29 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:29 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":349,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:29 volumio4 volumio[22460]: verbose: CURRENT POSITION 5 Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:29 volumio4 volumio[22460]: info: ------------------------------ 27ms Jan 20 17:51:29 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 17:51:29 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:29 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:29 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:29 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":349,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:29 volumio4 volumio[22460]: verbose: CURRENT POSITION 5 Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:29 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:29 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:29 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:29 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:29 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:29 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:29 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:29 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:29 volumio4 volumio[22460]: info: ------------------------------ 92ms Jan 20 17:51:29 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:29 volumio4 volumio[22460]: info: camilladsp spawned new process with pid 25183, instance 1, run: true Jan 20 17:51:29 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPrevious Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::previous Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: ControllerMpd::seek Jan 20 17:51:30 volumio4 volumio[22460]: error: null Jan 20 17:51:30 volumio4 volumio[22460]: info: Jan 20 17:51:30 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:30 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:30 volumio4 volumio[22460]: info: sendMpdCommand status took 1 milliseconds Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:30 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:30 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":349,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:30 volumio4 volumio[22460]: verbose: CURRENT POSITION 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:30 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:30 volumio4 volumio[22460]: info: ------------------------------ 66ms Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPrevious Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::previous Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::stop Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::updateTrackBlock Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrackBlock Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::serviceStop Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::serviceStop Jan 20 17:51:30 volumio4 volumio[22460]: info: ControllerMpd::stop Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:30 volumio4 volumio[22460]: info: Jan 20 17:51:30 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:30 volumio4 volumio[22460]: info: sendMpdCommand stop took 31 milliseconds Jan 20 17:51:30 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:30 volumio4 volumio[22460]: info: sendMpdCommand status took 8 milliseconds Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:30 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 45 milliseconds Jan 20 17:51:30 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:30 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: 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":"Acquainted","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/06. The Weeknd - Acquainted.mp3","trackType":"mp3"} Jan 20 17:51:30 volumio4 volumio[22460]: verbose: CURRENT POSITION 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService stop Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:30 volumio4 volumio[22460]: info: No code Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:30 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:30 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:30 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:30 volumio4 volumio[22460]: info: ------------------------------ 131ms Jan 20 17:51:30 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 20 17:51:31 volumio4 volumio[22460]: info: Discovery: Getting this device information Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::volumioGetState Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 5 Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::clearAddPlayTracks NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3 Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand stop Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand stop took 0 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand clear Jan 20 17:51:31 volumio4 volumio[22460]: info: Jan 20 17:51:31 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:31 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand clear took 0 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3" Jan 20 17:51:31 volumio4 volumio[22460]: error: updateQueue error: null Jan 20 17:51:31 volumio4 volumio[22460]: info: ------------------------------ 2ms Jan 20 17:51:31 volumio4 volumio[22460]: info: Jan 20 17:51:31 volumio4 volumio[22460]: ---------------------------- MPD announces system playlist update Jan 20 17:51:31 volumio4 volumio[22460]: info: Ignoring MPD Status Update Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand add "NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3" took 1 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:31 volumio4 volumio[22460]: info: ------------------------------ 1ms Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand play took 1 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: info: Jan 20 17:51:31 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:31 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:31 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:31 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:31 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:31 volumio4 volumio[22460]: info: Jan 20 17:51:31 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand status took 14 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand status took 2 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:31 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:31 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Hills","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3","trackType":"mp3"} Jan 20 17:51:31 volumio4 volumio[22460]: verbose: CURRENT POSITION 4 Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus stop Jan 20 17:51:31 volumio4 volumio[22460]: info: ------------------------------ 21ms Jan 20 17:51:31 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 20 17:51:31 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:31 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:31 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Hills","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3","trackType":"mp3"} Jan 20 17:51:31 volumio4 volumio[22460]: verbose: CURRENT POSITION 4 Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus play Jan 20 17:51:31 volumio4 volumio[22460]: info: Received an update from plugin. extracting info from payload Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:31 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:31 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:31 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:31 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:31 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:31 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:31 volumio4 volumio[22460]: info: ------------------------------ 66ms Jan 20 17:51:31 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:31 volumio4 volumio[22460]: info: camilladsp spawned new process with pid 25197, instance 1, run: true Jan 20 17:51:31 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:35 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolumemute Jan 20 17:51:35 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:35 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:35 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:35 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:35 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:35 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:37 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolumeunmute Jan 20 17:51:37 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:37 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:37 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:37 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:37 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:37 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:38 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:38 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:38 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:38 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:38 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:38 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:38 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:38 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:38 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:38 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:38 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:38 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:39 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:39 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:39 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:39 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:39 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:39 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:39 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:39 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:39 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:39 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:39 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume+ Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:39 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:39 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:39 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:40 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:40 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:40 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:40 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:41 volumio4 volumio[22460]: info: VolumeController::SetAlsaVolume- Jan 20 17:51:41 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:41 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:41 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:41 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:41 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:41 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPause Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::pause Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::servicePause Jan 20 17:51:46 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreCommandRouter::servicePause Jan 20 17:51:46 volumio4 volumio[22460]: info: ControllerMpd::pause Jan 20 17:51:46 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand pause Jan 20 17:51:46 volumio4 volumio[22460]: info: Jan 20 17:51:46 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:46 volumio4 volumio[22460]: info: sendMpdCommand pause took 1 milliseconds Jan 20 17:51:46 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:46 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:46 volumio4 volumio[22460]: info: sendMpdCommand status took 0 milliseconds Jan 20 17:51:46 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:46 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:46 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 17:51:46 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:46 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:46 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:46 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17108,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Hills","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3","trackType":"mp3"} Jan 20 17:51:46 volumio4 volumio[22460]: verbose: CURRENT POSITION 4 Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService pause Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus pause Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:46 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:46 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:46 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:46 volumio4 volumio[22460]: info: CoreStateMachine::stPlaybackTimer Jan 20 17:51:46 volumio4 volumio[22460]: info: ------------------------------ 31ms Jan 20 17:51:46 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:47 volumio4 kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Jan 20 17:51:47 volumio4 volumio[22460]: info: camilladsp spawned new process with pid 25313, instance 1, run: true Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPlay Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreStateMachine::play index undefined Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 20 17:51:48 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreStateMachine::startPlaybackTimer Jan 20 17:51:48 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:48 volumio4 volumio[22460]: info: ControllerMpd::resume Jan 20 17:51:48 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand play Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 17:51:48 volumio4 volumio[22460]: info: Jan 20 17:51:48 volumio4 volumio[22460]: ---------------------------- MPD announces state update: player Jan 20 17:51:48 volumio4 volumio[22460]: info: sendMpdCommand play took 21 milliseconds Jan 20 17:51:48 volumio4 volumio[22460]: info: ControllerMpd::getState Jan 20 17:51:48 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand status Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:48 volumio4 volumio[22460]: info: sendMpdCommand status took 5 milliseconds Jan 20 17:51:48 volumio4 volumio[22460]: verbose: ControllerMpd::parseState Jan 20 17:51:48 volumio4 volumio[22460]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 20 17:51:48 volumio4 volumio[22460]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 17:51:48 volumio4 volumio[22460]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 20 17:51:48 volumio4 volumio[22460]: verbose: ControllerMpd::parseTrackInfo Jan 20 17:51:48 volumio4 volumio[22460]: info: ControllerMpd::pushState Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreCommandRouter::servicePushState Jan 20 17:51:48 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:48 volumio4 volumio[22460]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18354,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Hills","artist":"The Weeknd","album":"Beauty Behind the Madness","uri":"NAS/Dm920/The Weeknd/The Weeknd - Beauty Behind the Madness/05. The Weeknd - The Hills.mp3","trackType":"mp3"} Jan 20 17:51:48 volumio4 volumio[22460]: verbose: CURRENT POSITION 4 Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreStateMachine::syncState stateService play Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreStateMachine::syncState currentStatus pause Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreStateMachine::pushState Jan 20 17:51:48 volumio4 volumio[22460]: info: CorePlayQueue::getTrack 4 Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 17:51:48 volumio4 volumio[22460]: info: CoreCommandRouter::volumioPushState Jan 20 17:51:48 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output update for this device Jan 20 17:51:48 volumio4 volumio[22460]: info: MRS: Pushing multiroomSync output Jan 20 17:51:48 volumio4 volumio[22460]: info: ------------------------------ 48ms Jan 20 17:51:48 volumio4 volumio[22460]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 20 17:51:50 volumio4 volumio[22460]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 17:51:50 volumio4 volumio[22460]: SyntaxError: Unexpected token + in JSON at position 0 Jan 20 17:51:50 volumio4 volumio[22460]: at JSON.parse () Jan 20 17:51:50 volumio4 volumio[22460]: at rotaryencoder2.emitPushCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:1048:17) Jan 20 17:51:50 volumio4 volumio[22460]: at Timeout._onTimeout (/data/plugins/system_hardware/rotaryencoder2/index.js:908:16) Jan 20 17:51:50 volumio4 volumio[22460]: at listOnTimeout (internal/timers.js:554:17) Jan 20 17:51:50 volumio4 volumio[22460]: at processTimers (internal/timers.js:497:7) Jan 20 17:51:50 volumio4 volumio[22460]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 17:51:51 volumio4 sudo[25337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 17:50 Jan 20 17:51:51 volumio4 sudo[25337]: 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="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="d316d397153fbb98c246d670c12f98a120b995a2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 11 Jan 2025 10:58:50 AM CET" VOLUMIO_VERSION="3.788" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e6f1869148b01453dc48d3e2d79d1421"