-- Logs begin at Sat 2024-07-20 15:59:04 UTC, end at Mon 2024-07-22 16:07:10 UTC. --
Jul 22 16:06:01 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:01 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:01 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 50
Jul 22 16:06:01 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:01 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:02 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:03 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:03 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:03 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 49
Jul 22 16:06:03 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:03 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:05 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:05 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:05 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 48
Jul 22 16:06:05 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:05 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:06 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:06 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:06 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 47
Jul 22 16:06:06 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:06 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:07 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:07 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:07 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 46
Jul 22 16:06:07 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:07 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:08 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:08 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:08 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 45
Jul 22 16:06:08 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:08 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:09 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:09 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:09 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 44
Jul 22 16:06:09 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:09 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:09 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:09 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:09 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 43
Jul 22 16:06:09 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:09 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:10 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:10 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:10 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:10 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 42
Jul 22 16:06:10 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:10 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:11 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:11 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:11 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 41
Jul 22 16:06:11 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:11 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:12 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:12 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:12 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 40
Jul 22 16:06:12 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:12 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:12 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:12 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:12 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 39
Jul 22 16:06:12 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:12 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:12 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:12 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:12 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 38
Jul 22 16:06:12 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:12 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:14 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:14 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:14 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 37
Jul 22 16:06:14 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:14 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:14 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:14 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:14 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 36
Jul 22 16:06:14 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:14 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:15 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:15 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:15 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 35
Jul 22 16:06:15 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:15 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:15 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:15 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:15 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 34
Jul 22 16:06:15 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:15 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:16 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:16 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:16 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 33
Jul 22 16:06:16 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:16 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:17 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:17 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:17 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 32
Jul 22 16:06:17 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:17 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:17 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:17 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:17 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 31
Jul 22 16:06:17 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:17 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:17 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:17 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:17 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:17 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 30
Jul 22 16:06:17 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:17 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:19 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:19 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:19 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 29
Jul 22 16:06:19 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:19 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:19 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:19 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:19 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 28
Jul 22 16:06:19 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:19 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:20 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:20 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:20 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 27
Jul 22 16:06:20 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:20 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:20 volumio volumio[1260]: info: CoreCommandRouter::volumioRemoveQueueItem
Jul 22 16:06:20 volumio volumio[1260]: info: CoreStateMachine::removeQueueItem
Jul 22 16:06:20 volumio volumio[1260]: info: CorePlayQueue::removeQueueItem 26
Jul 22 16:06:20 volumio volumio[1260]: info: CorePlayQueue::saveQueue
Jul 22 16:06:20 volumio volumio[1260]: info: CoreCommandRouter::volumioPushQueue
Jul 22 16:06:21 volumio volumio[1260]: info: CorePlayQueue::getTrack 30
Jul 22 16:06:21 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:21 volumio volumio[1260]: info: Prefetching next song
Jul 22 16:06:21 volumio volumio[1260]: info: DOING PREFETCH IN MPD
Jul 22 16:06:21 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand add "USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav"
Jul 22 16:06:21 volumio volumio[1260]: info: sendMpdCommand add "USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav" took 1 milliseconds
Jul 22 16:06:21 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand consume 1
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info: sendMpdCommand consume 1 took 2 milliseconds
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info:
Jul 22 16:06:21 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:21 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 12ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 10ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 8ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 7ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 6ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 5ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 4ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 4ms
Jul 22 16:06:21 volumio volumio[1260]: info: ------------------------------ 3ms
Jul 22 16:06:25 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::startPlaybackTimer
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 7ms
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces system playlist update
Jul 22 16:06:25 volumio volumio[1260]: info: Ignoring MPD Status Update
Jul 22 16:06:25 volumio volumio[1260]: info:
Jul 22 16:06:25 volumio volumio[1260]: ---------------------------- MPD announces state update: player
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::getState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand status
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 18 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 18ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 17 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 17ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 16 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 15ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 15 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 13ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 12 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 12ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 11 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 11ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 9 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 10ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 8 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 7ms
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand status took 6 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseState
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: verbose: ControllerMpd::parseTrackInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ControllerMpd::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::servicePushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"LITTLE BIT OF LOVE","artist":"Stanley Thomas Keiser","album":null,"uri":"USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Stanley Thomas Keiser - Secret Island/LITTLE BIT OF LOVE.wav","trackType":"wav"}
Jul 22 16:06:25 volumio volumio[1260]: verbose: CURRENT POSITION 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState stateService play
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::syncState currentStatus play
Jul 22 16:06:25 volumio volumio[1260]: info: Received an update from plugin. extracting info from payload
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: CoreStateMachine::pushState
Jul 22 16:06:25 volumio volumio[1260]: info: CorePlayQueue::getTrack 31
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::volumioPushState
Jul 22 16:06:25 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 139ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 138ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 137ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 137ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 135ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 134ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 132ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 131ms
Jul 22 16:06:25 volumio volumio[1260]: info: ------------------------------ 130ms
Jul 22 16:06:32 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:32 volumio volumio[1260]: info: CURURI: music-library
Jul 22 16:06:32 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:33 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:33 volumio volumio[1260]: info: CURURI: music-library/USB
Jul 22 16:06:33 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:33 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB
Jul 22 16:06:40 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:42 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:42 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01
Jul 22 16:06:44 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:44 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Accustic Arts Audiophile Recordings Uncompressed World - Vol.IV - Audiophile Solo Piano-20230217T153258Z-001
Jul 22 16:06:47 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:47 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/FIM Reference IV
Jul 22 16:06:48 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:50 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:50 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/Excellent Sound Recordings(1)
Jul 22 16:06:55 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:06:59 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:06:59 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/STS Master Recordings - Volume 2-20230217T153732Z-001
Jul 22 16:07:02 volumio volumio[1260]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 22 16:07:02 volumio volumio[1260]: info: CURURI: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/STS_Incredible Music & Recordings Volume 1_24 Bit MW Coding-20230217T091512Z-001
Jul 22 16:07:03 volumio wpa_supplicant[954]: wlan0: Failed to initiate sched scan
Jul 22 16:07:09 volumio volumio[1260]: info: CoreCommandRouter::volumioAddQueueItems
Jul 22 16:07:09 volumio volumio[1260]: info: CoreStateMachine::addQueueItems
Jul 22 16:07:09 volumio volumio[1260]: info: CorePlayQueue::addQueueItems
Jul 22 16:07:09 volumio volumio[1260]: info: Adding Item to queue: music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent
Jul 22 16:07:09 volumio volumio[1260]: info: Exploding uri music-library/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent in service mpd
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=TOMA%20%26%20MAMI%20with%20SATOSHI//extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens%2044116.wav&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens/01 Down by the Salley Gardens 44116.wav
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=TOMA%20%26%20MAMI%20with%20SATOSHI//extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens%2F02%20Down%20by%20the%20Salley%20Gardens%2019224.wav&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens/02 Down by the Salley Gardens 19224.wav
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=TOMA%20%26%20MAMI%20with%20SATOSHI//extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens%2F03%20Down%20by%20the%20Salley%20Gardens%2038432.wav&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens/03 Down by the Salley Gardens 38432.wav
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=TOMA%20%26%20MAMI%20with%20SATOSHI/Stereo%20Sound%20Hi-Res%20Reference%20Check%20Disc/extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens%2F04%20Down%20by%20the%20Salley%20Gardens%20DSD128.dsf&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens/04 Down by the Salley Gardens DSD128.dsf
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=TOMA%20%26%20MAMI%20with%20SATOSHI/Stereo%20Sound%20Hi-Res%20Reference%20Check%20Disc/extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens%2F05%20Down%20by%20the%20Salley%20Gardens%20DSD256.dsf&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens/05 Down by the Salley Gardens DSD256.dsf
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=//extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens.zip&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens.zip
Jul 22 16:07:09 volumio volumio[1260]: info: ALBUMART /albumart?cacheid=98&web=//extralarge&path=%2Fmnt%2FUSB%2FFREE1TB%2FSPECIAL%20SELECTION%20MUSIC%2001%2Fstereo%20sound%20hires%20referent%2F01%20Down%20by%20the%20Salley%20Gardens%2F01%20Down%20by%20the%20Salley%20Gardens.zip&metadata=false
Jul 22 16:07:09 volumio volumio[1260]: info: URI /mnt/USB/FREE1TB/SPECIAL SELECTION MUSIC 01/stereo sound hires referent/01 Down by the Salley Gardens/01 Down by the Salley Gardens.zip
Jul 22 16:07:09 volumio volumio[1260]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 16:07:09 volumio volumio[1260]: Error: Unable to resolve or reject the same promise twice
Jul 22 16:07:09 volumio volumio[1260]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Jul 22 16:07:09 volumio volumio[1260]: at /volumio/app/plugins/music_service/mpd/index.js:2520:21
Jul 22 16:07:09 volumio volumio[1260]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Jul 22 16:07:09 volumio volumio[1260]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Jul 22 16:07:09 volumio volumio[1260]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Jul 22 16:07:09 volumio volumio[1260]: at emitOne (events.js:116:13)
Jul 22 16:07:09 volumio volumio[1260]: at Socket.emit (events.js:211:7)
Jul 22 16:07:09 volumio volumio[1260]: at addChunk (_stream_readable.js:263:12)
Jul 22 16:07:09 volumio volumio[1260]: at readableAddChunk (_stream_readable.js:246:13)
Jul 22 16:07:09 volumio volumio[1260]: at Socket.Readable.push (_stream_readable.js:208:10)
Jul 22 16:07:09 volumio volumio[1260]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 22 16:07:10 volumio sudo[6469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 16:06
Jul 22 16:07:10 volumio sudo[6469]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"