-- Logs begin at Wed 2025-04-30 05:25:07 CEST, end at Wed 2025-04-30 07:00:51 CEST. --
Apr 30 06:59:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:00 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:00 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:01 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:01 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:01 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:01 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:02 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:02 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:02 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:02 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:03 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:03 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:03 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:03 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:04 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:04 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:04 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:04 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:05 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:05 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:05 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:05 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:06 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:06 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:06 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:06 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:07 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:07 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:07 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:07 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:08 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:08 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:08 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:08 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:09 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:09 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:09 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:09 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:10 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:10 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:10 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:10 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:10 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:10 volumio-living volumio[747]: info: Listing playlists
Apr 30 06:59:10 volumio-living volumio[747]: info: Listing playlists
Apr 30 06:59:11 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:11 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:11 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:11 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:12 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:12 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:12 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:12 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:13 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:13 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:13 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:13 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:14 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:14 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:14 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:14 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:15 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:15 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:15 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:15 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:16 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:16 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:16 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:16 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:17 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:17 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:17 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:17 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:18 volumio-living volumio[747]: info:
Apr 30 06:59:18 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 06:59:18 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 06:59:18 volumio-living volumio[747]: info:
Apr 30 06:59:18 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 06:59:18 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 06:59:18 volumio-living volumio[747]: info:
Apr 30 06:59:18 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 06:59:18 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 06:59:18 volumio-living volumio[747]: info:
Apr 30 06:59:18 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 06:59:18 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 06:59:18 volumio-living volumio[747]: info:
Apr 30 06:59:18 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 06:59:18 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 06:59:18 volumio-living volumio[747]: info:
Apr 30 06:59:18 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 06:59:18 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 06:59:18 volumio-living volumio[747]: info: ------------------------------ 3ms
Apr 30 06:59:18 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 06:59:18 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 06:59:18 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 06:59:18 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 06:59:18 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 06:59:18 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 06:59:18 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 06:59:18 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 06:59:18 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 06:59:18 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 06:59:18 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32494182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Leen De Witte en Jasper Verhulst","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 06:59:18 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 06:59:18 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:18 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 06:59:18 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32494182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Leen De Witte en Jasper Verhulst","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 06:59:18 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 06:59:18 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:18 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 06:59:18 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32494182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Leen De Witte en Jasper Verhulst","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 06:59:18 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 06:59:18 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:18 volumio-living volumio[747]: info: ------------------------------ 22ms
Apr 30 06:59:18 volumio-living volumio[747]: info: ------------------------------ 22ms
Apr 30 06:59:18 volumio-living volumio[747]: info: ------------------------------ 21ms
Apr 30 06:59:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:18 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:18 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:19 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:19 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:19 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:19 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:20 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:20 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:20 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:20 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:20 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:21 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:21 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:21 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:21 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:22 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:22 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:22 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:22 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:23 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:23 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:23 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:23 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:24 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:24 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:24 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:24 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:25 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:25 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:25 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:25 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:26 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:26 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:26 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:26 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:27 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:27 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:27 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:27 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:28 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:28 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:28 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:28 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:29 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:29 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:29 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:29 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:30 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:30 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:30 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:30 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:30 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:30 volumio-living volumio[747]: info: Listing playlists
Apr 30 06:59:31 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:31 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:31 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:31 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:32 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:32 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:32 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:32 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:33 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:33 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:33 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:33 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:34 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:34 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:34 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:34 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:35 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:35 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:35 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:35 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:36 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:36 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:36 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:36 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:37 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:37 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:37 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:37 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:38 volumio-living volumio[747]: info:
Apr 30 06:59:38 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 06:59:38 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 06:59:38 volumio-living volumio[747]: info:
Apr 30 06:59:38 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 06:59:38 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 06:59:38 volumio-living volumio[747]: info:
Apr 30 06:59:38 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 06:59:38 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 06:59:38 volumio-living volumio[747]: info:
Apr 30 06:59:38 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 06:59:38 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 06:59:38 volumio-living volumio[747]: info:
Apr 30 06:59:38 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 06:59:38 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 06:59:38 volumio-living volumio[747]: info:
Apr 30 06:59:38 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 06:59:38 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 06:59:38 volumio-living volumio[747]: info: ------------------------------ 3ms
Apr 30 06:59:38 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 06:59:38 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 06:59:38 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 06:59:38 volumio-living volumio[747]: info: ------------------------------ 1ms
Apr 30 06:59:38 volumio-living volumio[747]: info: sendMpdCommand status took 1 milliseconds
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 06:59:38 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 06:59:38 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 06:59:38 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 06:59:38 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 06:59:38 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 06:59:38 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32514282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio 1 - Alles begint bij luisteren","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 06:59:38 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 06:59:38 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:38 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 06:59:38 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32514282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio 1 - Alles begint bij luisteren","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 06:59:38 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 06:59:38 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:38 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 06:59:38 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32514282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio 1 - Alles begint bij luisteren","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 06:59:38 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 06:59:38 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 06:59:38 volumio-living volumio[747]: info: ------------------------------ 21ms
Apr 30 06:59:38 volumio-living volumio[747]: info: ------------------------------ 20ms
Apr 30 06:59:38 volumio-living volumio[747]: info: ------------------------------ 19ms
Apr 30 06:59:38 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 06:59:38 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:38 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:38 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:39 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:39 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:39 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:39 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:40 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:40 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:40 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:40 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:40 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:41 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:41 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:42 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:42 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:42 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:42 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:43 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:43 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:43 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:43 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:44 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:44 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:44 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:44 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:45 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:45 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:45 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:45 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:46 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:46 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:46 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:46 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:47 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:47 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:47 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:47 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:48 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:48 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:48 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:48 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:49 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:49 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:49 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:49 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:50 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:50 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:50 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:50 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:50 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:50 volumio-living volumio[747]: info: Listing playlists
Apr 30 06:59:50 volumio-living volumio[747]: info: Listing playlists
Apr 30 06:59:51 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:51 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:51 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:51 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:52 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:52 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:52 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:52 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:53 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:53 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:53 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:53 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:54 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:54 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:54 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:54 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:55 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:55 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:55 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:55 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:56 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:56 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:56 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:56 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:57 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:57 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:57 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:57 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:58 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:58 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:58 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:58 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 06:59:59 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 06:59:59 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 06:59:59 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 06:59:59 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:00 volumio-living volumio[747]: info:
Apr 30 07:00:00 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:00 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:00 volumio-living volumio[747]: info:
Apr 30 07:00:00 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:00 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:00 volumio-living volumio[747]: info:
Apr 30 07:00:00 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:00 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:00 volumio-living volumio[747]: info:
Apr 30 07:00:00 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:00 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:00 volumio-living volumio[747]: info:
Apr 30 07:00:00 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:00 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:00 volumio-living volumio[747]: info:
Apr 30 07:00:00 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:00 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:00 volumio-living volumio[747]: info: ------------------------------ 3ms
Apr 30 07:00:00 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 07:00:00 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 07:00:00 volumio-living volumio[747]: info: sendMpdCommand status took 3 milliseconds
Apr 30 07:00:00 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 07:00:00 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:00 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:00 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:00 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:00 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:00 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:00 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32536587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"De Ochtend","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:00 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:00 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:00 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:00 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32536587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"De Ochtend","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:00 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:00 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:00 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:00 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32536587,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"De Ochtend","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:00 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:00 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:00 volumio-living volumio[747]: info: ------------------------------ 20ms
Apr 30 07:00:00 volumio-living volumio[747]: info: ------------------------------ 19ms
Apr 30 07:00:00 volumio-living volumio[747]: info: ------------------------------ 19ms
Apr 30 07:00:00 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:00 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:00 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:00 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:00 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:01 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:01 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:01 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:01 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:02 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:02 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:02 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:02 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:03 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:03 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:03 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:03 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:04 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:04 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:04 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:04 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:05 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:05 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:05 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:05 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:06 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:06 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:06 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:06 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:07 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:07 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:07 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:07 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:08 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:08 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:08 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:08 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:09 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:09 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:09 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:09 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:10 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:10 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:10 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:10 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:10 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:11 volumio-living volumio[747]: info: Listing playlists
Apr 30 07:00:11 volumio-living volumio[747]: info: Listing playlists
Apr 30 07:00:11 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:11 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:11 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:11 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:12 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:12 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:12 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:12 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:13 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:13 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:13 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:13 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:14 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:14 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:14 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:14 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:15 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:15 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:15 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:15 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:16 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:16 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:16 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:16 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:17 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:17 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:17 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:17 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:18 volumio-living volumio[747]: info:
Apr 30 07:00:18 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:18 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:18 volumio-living volumio[747]: info:
Apr 30 07:00:18 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:18 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:18 volumio-living volumio[747]: info:
Apr 30 07:00:18 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:18 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:18 volumio-living volumio[747]: info:
Apr 30 07:00:18 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:18 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:18 volumio-living volumio[747]: info:
Apr 30 07:00:18 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:18 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:18 volumio-living volumio[747]: info:
Apr 30 07:00:18 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:18 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:18 volumio-living volumio[747]: info: ------------------------------ 3ms
Apr 30 07:00:18 volumio-living volumio[747]: info: sendMpdCommand status took 4 milliseconds
Apr 30 07:00:18 volumio-living volumio[747]: info: ------------------------------ 3ms
Apr 30 07:00:18 volumio-living volumio[747]: info: sendMpdCommand status took 3 milliseconds
Apr 30 07:00:18 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 07:00:18 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:18 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:18 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:18 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:18 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:18 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:18 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32554478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Leen De Witte en Jasper Verhulst","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:18 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:18 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:18 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:18 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32554478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Leen De Witte en Jasper Verhulst","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:18 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:18 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:18 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:18 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32554478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Leen De Witte en Jasper Verhulst","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:18 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:18 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:18 volumio-living volumio[747]: info: ------------------------------ 19ms
Apr 30 07:00:18 volumio-living volumio[747]: info: ------------------------------ 19ms
Apr 30 07:00:18 volumio-living volumio[747]: info: ------------------------------ 18ms
Apr 30 07:00:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:18 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:18 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:18 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:19 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:19 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:19 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:19 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:20 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:20 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:20 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:20 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:20 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:21 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:21 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:21 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:21 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:22 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:22 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:22 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:22 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:23 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:23 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:23 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:23 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:24 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:24 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:24 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:24 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:25 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:25 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:25 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:25 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:26 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:26 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:26 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:26 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:27 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:27 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:27 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:27 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:28 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:28 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:28 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:28 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:29 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:29 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:29 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:29 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:30 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:30 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:30 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:30 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:30 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:31 volumio-living volumio[747]: info: Listing playlists
Apr 30 07:00:31 volumio-living volumio[747]: info: Listing playlists
Apr 30 07:00:31 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:31 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:31 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:31 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:32 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:32 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:32 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:32 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:33 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:33 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:33 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:33 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:34 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:34 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:34 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:34 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:35 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:35 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:35 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:35 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:36 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:36 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:36 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:36 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:37 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:37 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:37 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:37 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:38 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:38 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:38 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:39 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:39 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:39 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:39 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:40 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:40 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:40 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:40 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:41 volumio-living volumio[747]: info:
Apr 30 07:00:41 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:41 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:41 volumio-living volumio[747]: info:
Apr 30 07:00:41 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:41 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:41 volumio-living volumio[747]: info:
Apr 30 07:00:41 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:41 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:41 volumio-living volumio[747]: info:
Apr 30 07:00:41 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:41 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:41 volumio-living volumio[747]: info:
Apr 30 07:00:41 volumio-living volumio[747]: ---------------------------- MPD announces system playlist update
Apr 30 07:00:41 volumio-living volumio[747]: info: Ignoring MPD Status Update
Apr 30 07:00:41 volumio-living volumio[747]: info:
Apr 30 07:00:41 volumio-living volumio[747]: ---------------------------- MPD announces state update: player
Apr 30 07:00:41 volumio-living volumio[747]: info: ControllerMpd::getState
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand status
Apr 30 07:00:41 volumio-living volumio[747]: info: ------------------------------ 4ms
Apr 30 07:00:41 volumio-living volumio[747]: info: sendMpdCommand status took 3 milliseconds
Apr 30 07:00:41 volumio-living volumio[747]: info: ------------------------------ 3ms
Apr 30 07:00:41 volumio-living volumio[747]: info: sendMpdCommand status took 2 milliseconds
Apr 30 07:00:41 volumio-living volumio[747]: info: ------------------------------ 2ms
Apr 30 07:00:41 volumio-living volumio[747]: info: sendMpdCommand status took 1 milliseconds
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::parseState
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 30 07:00:41 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:41 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 30 07:00:41 volumio-living volumio[747]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:41 volumio-living volumio[747]: verbose: ControllerMpd::parseTrackInfo
Apr 30 07:00:41 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:41 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32577586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio 1 - Alles begint bij luisteren","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:41 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:41 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:41 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:41 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32577586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio 1 - Alles begint bij luisteren","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:41 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:41 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:41 volumio-living volumio[747]: info: ControllerMpd::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::servicePushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CorePlayQueue::getTrack 0
Apr 30 07:00:41 volumio-living volumio[747]: verbose: STATE SERVICE {"status":"play","position":0,"seek":32577586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Radio 1 - Alles begint bij luisteren","artist":"VRT Radio 1","album":null,"uri":"http://icecast.vrtcdn.be/radio1-high.mp3/tunein","trackType":"mp3/tunein"}
Apr 30 07:00:41 volumio-living volumio[747]: verbose: CURRENT POSITION 0
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::syncState stateService play
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::syncState currentStatus play
Apr 30 07:00:41 volumio-living volumio[747]: info: Received an update from plugin. extracting info from payload
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::pushState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioPushState
Apr 30 07:00:41 volumio-living volumio[747]: info: ------------------------------ 19ms
Apr 30 07:00:41 volumio-living volumio[747]: info: ------------------------------ 18ms
Apr 30 07:00:41 volumio-living volumio[747]: info: ------------------------------ 17ms
Apr 30 07:00:41 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:41 volumio-living volumio[747]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:41 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:41 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:42 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:42 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:42 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:42 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:43 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:43 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:43 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:43 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:44 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:44 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:44 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:44 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:45 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:45 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:45 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:45 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:46 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:46 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:46 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:46 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:47 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:47 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:47 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:47 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:48 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:48 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:48 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:48 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:49 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:49 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:49 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:49 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:50 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:50 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetQueue
Apr 30 07:00:50 volumio-living volumio[747]: info: CoreStateMachine::getQueue
Apr 30 07:00:50 volumio-living volumio[747]: info: CorePlayQueue::getQueue
Apr 30 07:00:51 volumio-living volumio[747]: info: CoreCommandRouter::volumioGetState
Apr 30 07:00:51 volumio-living volumio[747]: info: Listing playlists
Apr 30 07:00:51 volumio-living volumio[747]: info: Listing playlists
Apr 30 07:00:51 volumio-living volumio[747]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 30 07:00:51 volumio-living volumio[747]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] {
Apr 30 07:00:51 volumio-living volumio[747]: code: 'auth/network-request-failed',
Apr 30 07:00:51 volumio-living volumio[747]: a: null
Apr 30 07:00:51 volumio-living volumio[747]: }
Apr 30 07:00:51 volumio-living volumio[747]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 30 07:00:51 volumio-living sudo[16111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-30 06:59
Apr 30 07:00:51 volumio-living sudo[16111]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"