-- Logs begin at Fri 2024-04-05 14:59:25 UTC, end at Fri 2024-04-26 13:21:14 UTC. -- Apr 26 13:20:10 opera systemd-journal[246]: Suppressed 7374 messages from /system.slice/volumio.service Apr 26 13:20:10 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:10 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 14ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 14ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 14ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 14ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 5 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 19ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 14 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 19ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 19 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 2 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 14 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 0 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 14 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 0 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 14 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:11 opera volumio[1124]: info: Apr 26 13:20:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 0 milliseconds Apr 26 13:20:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:11 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 21 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 21ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 24 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 2 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 18ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 18ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 21ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 21 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 17 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 0 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 17ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 18ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 19 milliseconds Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:12 opera volumio[1124]: info: Apr 26 13:20:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:12 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 20ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 20 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 0 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 14 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 20ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 19 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 0 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 19ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 19 milliseconds Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:13 opera volumio[1124]: info: Apr 26 13:20:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 0 milliseconds Apr 26 13:20:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:13 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 0 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 19ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 19 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 0 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 0 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 15ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 15 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:14 opera volumio[1124]: info: Apr 26 13:20:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 0 milliseconds Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:14 opera volumio[1124]: info: ------------------------------ 16ms Apr 26 13:20:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 16 milliseconds Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:14 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:41 opera systemd-journal[246]: Suppressed 7271 messages from /system.slice/volumio.service Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 0 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 0 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 20 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 2 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 24ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 19 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 27ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 20 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 0 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 21 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 24ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 24 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 20 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 28ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 28 milliseconds Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:41 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:41 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:41 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:41 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:41 opera volumio[1124]: info: Apr 26 13:20:41 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:41 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:41 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:41 opera volumio[1124]: info: ------------------------------ 27ms Apr 26 13:20:41 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 20 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 25ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 25 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 20 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 0 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 27ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 4 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 26ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 23 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 0 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 25ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 25 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:42 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:42 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:42 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:42 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:42 opera volumio[1124]: info: Apr 26 13:20:42 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:42 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:20:42 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:42 opera volumio[1124]: info: ------------------------------ 29ms Apr 26 13:20:42 opera volumio[1124]: info: sendMpdCommand consume 1 took 28 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 28 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 0 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 0 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 28ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 0 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 26ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 25 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 0 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 27ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 0 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 22 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:43 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:43 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:20:43 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:43 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:43 opera volumio[1124]: info: Apr 26 13:20:43 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:43 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:20:43 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:43 opera volumio[1124]: info: ------------------------------ 24ms Apr 26 13:20:43 opera volumio[1124]: info: sendMpdCommand consume 1 took 24 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 0 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 28ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 28ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 27 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 22ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 24ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 25 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 4 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 26ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 23ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 23 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:44 opera volumio[1124]: info: Apr 26 13:20:44 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:20:44 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:20:44 opera volumio[1124]: info: ------------------------------ 25ms Apr 26 13:20:44 opera volumio[1124]: info: sendMpdCommand consume 1 took 25 milliseconds Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:20:44 opera volumio[1124]: info: Prefetching next song Apr 26 13:20:44 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:20:44 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:20:44 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:20:44 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:11 opera systemd-journal[246]: Suppressed 7247 messages from /system.slice/volumio.service Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 59ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 59 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 60 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 3 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 29ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 57ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 56 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 56 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 36ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 36 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 29ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 2 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 54ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 54 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 54 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 33 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 0 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 29 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 2 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 57ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 58 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 58 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:11 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:11 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:21:11 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:11 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:11 opera volumio[1124]: info: Apr 26 13:21:11 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:11 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:21:11 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:11 opera volumio[1124]: info: ------------------------------ 39ms Apr 26 13:21:11 opera volumio[1124]: info: sendMpdCommand consume 1 took 39 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 4 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 37ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 34 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 32 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 37ms Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 41 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 42ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 39 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 33 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 30 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 42ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 39 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 36 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 34 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 33 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 31 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 3 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 33 milliseconds Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:12 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:12 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:21:12 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:12 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:12 opera volumio[1124]: info: Apr 26 13:21:12 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:12 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 5 milliseconds Apr 26 13:21:12 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:12 opera volumio[1124]: info: ------------------------------ 38ms Apr 26 13:21:12 opera volumio[1124]: info: sendMpdCommand consume 1 took 37 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 25 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 41ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 40 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 34 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 29 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 25 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 37ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 37 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 30 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 0 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 30ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 1 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 34 milliseconds Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:13 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:13 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:21:13 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:13 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:13 opera volumio[1124]: info: Apr 26 13:21:13 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:13 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 2 milliseconds Apr 26 13:21:13 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:13 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:13 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3130.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 35ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 33 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3131.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 3 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3132.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 4 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3133.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 39ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 37 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 5 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3134.wav" took 4 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 6 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3135.wav" took 5 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 7 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3136.wav" took 4 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 33ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 8 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3137.wav" took 4 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 37ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 34 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 9 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3138.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 32 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 10 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3139.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 34ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 11 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3140.wav" took 3 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 41ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 40 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 12 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3128.wav" took 2 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 32ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 0 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song Apr 26 13:21:14 opera volumio[1124]: info: Doing Prefetch in UPNP Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" Apr 26 13:21:14 opera volumio[1124]: info: CoreStateMachine::startPlaybackTimer Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:14 opera volumio[1124]: info: Apr 26 13:21:14 opera volumio[1124]: ---------------------------- MPD announces system playlist update Apr 26 13:21:14 opera volumio[1124]: info: Ignoring MPD Status Update Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand add "http://192.168.100.147:8200/MediaItems/3129.wav" took 1 milliseconds Apr 26 13:21:14 opera volumio[1124]: verbose: ControllerMpd::sendMpdCommand consume 1 Apr 26 13:21:14 opera volumio[1124]: info: ------------------------------ 31ms Apr 26 13:21:14 opera volumio[1124]: info: sendMpdCommand consume 1 took 31 milliseconds Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 1 Apr 26 13:21:14 opera volumio[1124]: info: CorePlayQueue::getTrack 2 Apr 26 13:21:14 opera volumio[1124]: info: Prefetching next song PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"