-- Logs begin at Wed 2025-01-15 06:52:36 UTC, end at Sat 2025-01-18 06:58:03 UTC. -- Jan 18 06:57:01 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:01 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:01 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:02 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:02 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 15. Jan 18 06:57:02 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:02 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:02 ifi-phmidsd-idsd-phantom play[4022]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:02 ifi-phmidsd-idsd-phantom play[4022]: aplay: device_list:272: no soundcards found... Jan 18 06:57:02 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:04 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:04 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:04 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2719]: .............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................++++ Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2719]: e is 65537 (0x010001) Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2719]: writing RSA key Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: error: Could not retrieve plugin system_controller my_volumio Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: Received Get System Version Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: Received Get System Info Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: Discovery: Getting this device information Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:04 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 06:57:05 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:05 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 16. Jan 18 06:57:05 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:05 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:05 ifi-phmidsd-idsd-phantom play[4123]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:05 ifi-phmidsd-idsd-phantom play[4123]: aplay: device_list:272: no soundcards found... Jan 18 06:57:05 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:05 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:06 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:07 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:07 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:07 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:08 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:08 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 17. Jan 18 06:57:08 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:08 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:08 ifi-phmidsd-idsd-phantom play[4191]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:09 ifi-phmidsd-idsd-phantom play[4191]: aplay: device_list:272: no soundcards found... Jan 18 06:57:09 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:09 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:10 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:10 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:10 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:11 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:11 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 18. Jan 18 06:57:11 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:11 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:12 ifi-phmidsd-idsd-phantom play[4261]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:12 ifi-phmidsd-idsd-phantom play[4261]: aplay: device_list:272: no soundcards found... Jan 18 06:57:12 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:12 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:13 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:13 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:13 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:15 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:15 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 19. Jan 18 06:57:15 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:15 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:15 ifi-phmidsd-idsd-phantom play[4366]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:15 ifi-phmidsd-idsd-phantom play[4366]: aplay: device_list:272: no soundcards found... Jan 18 06:57:16 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:16 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:17 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:17 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:17 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:18 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:18 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 20. Jan 18 06:57:18 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:18 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumiologrotate[489]: ls: cannot access '/var/log/samba/log.wb-IDSD': No such file or directory Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumiologrotate[489]: ls: cannot access 'PHANTOM': No such file or directory Jan 18 06:57:19 ifi-phmidsd-idsd-phantom play[4437]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:19 ifi-phmidsd-idsd-phantom play[4437]: aplay: device_list:272: no soundcards found... Jan 18 06:57:19 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:19 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:21 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:21 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:21 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:22 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:22 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 21. Jan 18 06:57:22 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:22 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:22 ifi-phmidsd-idsd-phantom play[4573]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:23 ifi-phmidsd-idsd-phantom play[4573]: aplay: device_list:272: no soundcards found... Jan 18 06:57:23 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:23 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:24 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:24 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:24 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:25 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:25 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 22. Jan 18 06:57:25 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:25 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:26 ifi-phmidsd-idsd-phantom play[4652]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:26 ifi-phmidsd-idsd-phantom play[4652]: aplay: device_list:272: no soundcards found... Jan 18 06:57:26 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:26 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:28 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:28 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:28 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:29 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:29 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 23. Jan 18 06:57:29 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:29 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:29 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 06:57:29 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:29 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 06:57:29 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 06:57:30 ifi-phmidsd-idsd-phantom play[4723]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:30 ifi-phmidsd-idsd-phantom play[4723]: aplay: device_list:272: no soundcards found... Jan 18 06:57:30 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:30 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:31 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:31 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 18 06:57:31 ifi-phmidsd-idsd-phantom volumio[2163]: info: CURURI: music-library/USB Jan 18 06:57:31 ifi-phmidsd-idsd-phantom volumio[2163]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 18 06:57:31 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:31 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:31 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:31 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:33 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:33 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 24. Jan 18 06:57:33 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:33 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:33 ifi-phmidsd-idsd-phantom play[4812]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:33 ifi-phmidsd-idsd-phantom play[4812]: aplay: device_list:272: no soundcards found... Jan 18 06:57:33 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:33 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:35 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:35 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:35 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:36 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:36 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 25. Jan 18 06:57:36 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:36 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:37 ifi-phmidsd-idsd-phantom play[4896]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:37 ifi-phmidsd-idsd-phantom play[4896]: aplay: device_list:272: no soundcards found... Jan 18 06:57:37 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:37 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:39 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:39 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:39 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:40 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:40 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 26. Jan 18 06:57:40 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:40 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:40 ifi-phmidsd-idsd-phantom play[4971]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:41 ifi-phmidsd-idsd-phantom play[4971]: aplay: device_list:272: no soundcards found... Jan 18 06:57:41 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:41 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:42 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 06:57:42 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:42 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 06:57:42 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 06:57:42 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:42 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:42 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:43 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:43 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 27. Jan 18 06:57:43 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:43 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:43 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Sent Play Jan 18 06:57:43 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPlay Jan 18 06:57:43 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::play index undefined Jan 18 06:57:43 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:43 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:43 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: success Jan 18 06:57:44 ifi-phmidsd-idsd-phantom play[5050]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:44 ifi-phmidsd-idsd-phantom play[5050]: aplay: device_list:272: no soundcards found... Jan 18 06:57:44 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:44 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:45 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:45 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:45 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:46 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Sent Play Jan 18 06:57:46 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPlay Jan 18 06:57:46 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::play index undefined Jan 18 06:57:46 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:46 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:46 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: success Jan 18 06:57:47 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:47 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 28. Jan 18 06:57:47 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:47 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:47 ifi-phmidsd-idsd-phantom play[5133]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CURURI: music-library/USB Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 18 06:57:48 ifi-phmidsd-idsd-phantom play[5133]: aplay: device_list:272: no soundcards found... Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:48 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:48 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:49 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 06:57:49 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:49 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 06:57:49 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 06:57:49 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:49 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:49 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:49 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:50 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:50 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:57:50 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 06:57:50 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:50 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 29. Jan 18 06:57:50 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:50 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:51 ifi-phmidsd-idsd-phantom play[5208]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:51 ifi-phmidsd-idsd-phantom play[5208]: aplay: device_list:272: no soundcards found... Jan 18 06:57:51 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:51 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:52 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:52 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:52 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:57:52 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:57:52 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:53 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:53 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:53 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::ClearQueue Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:53 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::clearPlayQueue Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::saveQueue Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushQueue Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::addQueueItems Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::addQueueItems Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Adding Item to queue: https://media-ssl.musicradio.com/SmoothLondonMP3 Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushQueue Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::saveQueue Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::updateTrackBlock Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrackBlock Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Sent Play Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPlay Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::play index 0 Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::play index undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::startPlaybackTimer Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: error: Could not retrieve plugin miscellanea metavolumio Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: [1737183474103] ControllerWebradio::clearAddPlayTrack Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: success Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand stop took 30 milliseconds Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clear took 12 milliseconds Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand load "https://media-ssl.musicradio.com/SmoothLondonMP3" Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: error: updateQueue error: null Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 26ms Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: error: Upnp client error: Error: This socket has been ended by the other party Jan 18 06:57:54 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:54 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 30. Jan 18 06:57:54 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:54 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:54 ifi-phmidsd-idsd-phantom play[5295]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:54 ifi-phmidsd-idsd-phantom play[5295]: aplay: device_list:272: no soundcards found... Jan 18 06:57:54 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:54 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand add "https://media-ssl.musicradio.com/SmoothLondonMP3" Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: error: updateQueue error: null Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: error: updateQueue error: null Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 1755ms Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 1751ms Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand add "https://media-ssl.musicradio.com/SmoothLondonMP3" took 16 milliseconds Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand play Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 42ms Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand play took 30 milliseconds Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 27ms Jan 18 06:57:55 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 20ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:56 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:56 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 51 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 51 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 101 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clearerror took 68 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 65 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clearerror took 61 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 39 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 34 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 28 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 24 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 233ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 224ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clearerror took 120 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 108 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 105 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 98 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 96 milliseconds Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 339ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 331ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 262ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 258ms Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:57:56 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:57:57 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:57 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:57 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:57:57 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:57:57 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 31. Jan 18 06:57:57 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:57:57 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:57:57 ifi-phmidsd-idsd-phantom play[5384]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:57:58 ifi-phmidsd-idsd-phantom play[5384]: aplay: device_list:272: no soundcards found... Jan 18 06:57:58 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand stop took 5 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 14 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 10 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 6 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: 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":"SmoothLondonMP3","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/SmoothLondonMP3","trackType":""} Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus pause Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: 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":"SmoothLondonMP3","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/SmoothLondonMP3","trackType":""} Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus pause Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: 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":"SmoothLondonMP3","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/SmoothLondonMP3","trackType":""} Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus pause Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 198ms Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 195ms Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 192ms Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::updateTrackBlock Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrackBlock Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stPlaybackTimer Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: [1737183478472] ControllerWebradio::stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:57:58 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand stop took 23 milliseconds Jan 18 06:57:59 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Drop client roon-ready Jan 18 06:57:59 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jan 18 06:57:59 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jan 18 06:58:00 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jan 18 06:58:00 ifi-phmidsd-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 32. Jan 18 06:58:00 ifi-phmidsd-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Jan 18 06:58:00 ifi-phmidsd-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::ClearQueue Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::serviceStop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::serviceStop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready Stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::clearPlayQueue Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::saveQueue Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushQueue Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::addQueueItems Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::addQueueItems Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Preload queue cleared Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Adding Item to queue: https://media-ssl.musicradio.com/LBCLondon Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushQueue Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::saveQueue Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::updateTrackBlock Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrackBlock Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Sent Play Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPlay Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::play index 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::play index undefined Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::startPlaybackTimer Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: error: Could not retrieve plugin miscellanea metavolumio Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: [1737183481114] ControllerWebradio::clearAddPlayTrack Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: success Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand stop took 8 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clear Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clear took 7 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand load "https://media-ssl.musicradio.com/LBCLondon" Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: error: updateQueue error: null Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 20ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand add "https://media-ssl.musicradio.com/LBCLondon" Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: error: updateQueue error: null Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: error: updateQueue error: null Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 190ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 187ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand add "https://media-ssl.musicradio.com/LBCLondon" took 9 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand play Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces system playlist update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Ignoring MPD Status Update Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 25ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand play took 18 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 15ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 11ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom play[5455]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 43 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 41 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:58:01 ifi-phmidsd-idsd-phantom play[5455]: aplay: device_list:272: no soundcards found... Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 127 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clearerror took 106 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clearerror took 99 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 73 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 69 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 61 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 49 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LBCLondon","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/LBCLondon","trackType":""} Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService pause Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LBCLondon","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/LBCLondon","trackType":""} Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService pause Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 275ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 270ms Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- MPD announces state update: player Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::getState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand status Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand clearerror took 147 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 127 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 115 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 112 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand status took 20 milliseconds Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom node[455]: ConvSwitch: Add client roon-ready Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LBCLondon","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/LBCLondon","trackType":""} Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService pause Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus stop Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LBCLondon","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/LBCLondon","trackType":""} Jan 18 06:58:01 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService pause Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus stop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LBCLondon","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/LBCLondon","trackType":""} Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService pause Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus stop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 386ms Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 312ms Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 305ms Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioGetState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Getting webradio selection Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: sendMpdCommand playlistinfo took 163 milliseconds Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: ControllerMpd::parseTrackInfo Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ControllerMpd::pushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::servicePushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CorePlayQueue::getTrack 0 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LBCLondon","artist":null,"album":null,"uri":"https://media-ssl.musicradio.com/LBCLondon","trackType":""} Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: verbose: CURRENT POSITION 0 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState stateService pause Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::syncState currentStatus stop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::pushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioPushState Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ------------------------------ 230ms Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: ConvSwitch: Get message: request:pause Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready playback start Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreCommandRouter::volumioStop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::stop Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: info: Roon Ready metadata receiver is on Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: SyntaxError: /volumio/app/plugins/music_service/webradio/selection.json: Unexpected end of JSON input Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: at JSON.parse () Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: at Object.readFileSync (/volumio/node_modules/jsonfile/index.js:69:17) Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: at /volumio/app/plugins/music_service/webradio/index.js:1161:31 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: at /volumio/node_modules/graceful-fs/graceful-fs.js:144:16 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: at /volumio/node_modules/graceful-fs/graceful-fs.js:61:14 Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: at FSReqCallback.oncomplete (fs.js:180:23) Jan 18 06:58:02 ifi-phmidsd-idsd-phantom volumio[2163]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 06:58:03 ifi-phmidsd-idsd-phantom sudo[5547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 06:57 Jan 18 06:58:03 ifi-phmidsd-idsd-phantom sudo[5547]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="13920db6364cee6ee1813803e0fc9a58456d0b00" VOLUMIO_FE_VERSION="2a2328da668188a182327763398d0399c492a484" VOLUMIO_FE3_VERSION="3b0824bbfe5acb79136a7da6b6a4a664b9cf4b7b" VOLUMIO_BE_VERSION="c7bfba30c4ad36b6cca2eb9f65445e86150d26d5" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jan 15 14:56:30 CST 2025" VOLUMIO_VERSION="2.00.3" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="dd86a1c2552151523c9b3971b020eeba"