-- Logs begin at Wed 2025-05-21 03:13:46 MST, end at Wed 2025-05-21 03:24:23 MST. -- May 21 03:23:00 volumio squeezeboxserver[2799]: [03:23:00.888] output_flush:701 [0x62ef20]: joining thread index:1 (slot:0) May 21 03:23:00 volumio squeezeboxserver[2799]: [03:23:00.925] output_http_thread:367 [0x62ef20]: finishing thread index:1 (slot:0) - sent 11500423 bytes May 21 03:23:00 volumio squeezeboxserver[2799]: [03:23:00.927] output_http_thread:396 [0x62ef20]: exited thread index:1 (slot:0) May 21 03:23:00 volumio squeezeboxserver[2799]: [03:23:00.927] sendSTAT:165 [0x62ef20]: STAT:[STMf] msplayed 0 May 21 03:23:00 volumio squeezeboxserver[2799]: [03:23:00.927] AVTStop:180 [0x6b6120]: uPNP stop (cookie 0xb1) May 21 03:23:00 volumio squeezeboxserver[2799]: [03:23:00.928] sendSTAT:165 [0x62ef20]: STAT:[STMf] msplayed 0 May 21 03:23:00 volumio volumio[1044]: info: May 21 03:23:00 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:00 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:00 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:00 volumio volumio[1044]: info: May 21 03:23:00 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:00 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:00 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:00 volumio volumio[1044]: info: May 21 03:23:00 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:00 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:00 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:00 volumio volumio[1044]: info: sendMpdCommand status took 4 milliseconds May 21 03:23:00 volumio volumio[1044]: info: sendMpdCommand status took 3 milliseconds May 21 03:23:00 volumio volumio[1044]: info: sendMpdCommand status took 1 milliseconds May 21 03:23:00 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:00 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:00 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:01 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:01 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:01 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:01 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 5 milliseconds May 21 03:23:01 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 3 milliseconds May 21 03:23:01 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 4 milliseconds May 21 03:23:01 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:01 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:01 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:01 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:01 volumio volumio[1044]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unaccompanied Cello Suite No. 1 in G major, BWV 1007: I. Prélude","artist":"Yo-Yo Ma","album":"Nature at Play: J.S. Bach's Cello Suite No. 1 (Live from the Great Smoky Mountains)","uri":"http://192.168.1.59:45067/bridge-1.flac","trackType":"flac"} May 21 03:23:01 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::syncState stateService stop May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::stPlaybackTimer May 21 03:23:01 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:01 volumio volumio[1044]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unaccompanied Cello Suite No. 1 in G major, BWV 1007: I. Prélude","artist":"Yo-Yo Ma","album":"Nature at Play: J.S. Bach's Cello Suite No. 1 (Live from the Great Smoky Mountains)","uri":"http://192.168.1.59:45067/bridge-1.flac","trackType":"flac"} May 21 03:23:01 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::syncState stateService stop May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus stop May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: No code May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:01 volumio volumio[1044]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unaccompanied Cello Suite No. 1 in G major, BWV 1007: I. Prélude","artist":"Yo-Yo Ma","album":"Nature at Play: J.S. Bach's Cello Suite No. 1 (Live from the Great Smoky Mountains)","uri":"http://192.168.1.59:45067/bridge-1.flac","trackType":"flac"} May 21 03:23:01 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::syncState stateService stop May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus stop May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: No code May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:01 volumio volumio[1044]: info: ------------------------------ 98ms May 21 03:23:01 volumio volumio[1044]: info: ------------------------------ 101ms May 21 03:23:01 volumio volumio[1044]: info: ------------------------------ 101ms May 21 03:23:01 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:01 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:01 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.942] process_strm:234 [0x62ef20] strm command s May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.942] process_strm:304 [0x62ef20], strm s autostart: 3 transition period: 10 transition type: 0 codec: f May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.942] sendSTAT:165 [0x62ef20]: STAT:[STMf] msplayed 0 May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.953] output_start:158 [0x62ef20]: start thread index:2 (slot:0) May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.953] sq_callback:380 [0x6b6120]: May 21 03:23:02 volumio squeezeboxserver[2799]: artist:Yo-Yo Ma May 21 03:23:02 volumio squeezeboxserver[2799]: album:東邪西毒終極版 (電影原聲大碟) May 21 03:23:02 volumio squeezeboxserver[2799]: title:東邪西毒 May 21 03:23:02 volumio squeezeboxserver[2799]: duration:199000 May 21 03:23:02 volumio squeezeboxserver[2799]: live_duration:-1 May 21 03:23:02 volumio squeezeboxserver[2799]: position:0 May 21 03:23:02 volumio squeezeboxserver[2799]: cover:http://192.168.1.59:9000/imageproxy/http%3A%2F%2Fresources.tidal.com%2Fimages%2F58e47714%2Fb455%2F4a10%2Fa3f4%2Ff0c215458b10%2F1280x1280.jpg/image.jpg May 21 03:23:02 volumio squeezeboxserver[2799]: index:0 May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.953] sq_callback:429 [0x6b6120]: set current URI (g:0) http://192.168.1.59:41111/bridge-2.flac May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.953] AVTSetURI:69 [0x6b6120]: uPNP setURI http://192.168.1.59:41111/bridge-2.flac (cookie 0xb2) May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.953] process_start:1268 [0x62ef20]: codec:f, ch:0, s:0, r:0 May 21 03:23:02 volumio squeezeboxserver[2799]: [03:23:02.955] output_http_thread:193 [0x62ef20]: thread index:2 (slot:0) started, listening socket 14 (cache:1) May 21 03:23:02 volumio volumio[1044]: info: Clearing queue after UPNP request May 21 03:23:03 volumio volumio[1044]: info: CoreStateMachine::ClearQueue May 21 03:23:03 volumio volumio[1044]: info: CoreStateMachine::stop May 21 03:23:03 volumio volumio[1044]: info: CoreStateMachine::setConsumeUpdateService undefined May 21 03:23:03 volumio volumio[1044]: info: CorePlayQueue::clearPlayQueue May 21 03:23:03 volumio volumio[1044]: info: CorePlayQueue::saveQueue May 21 03:23:03 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:03 volumio volumio[1044]: info: CoreCommandRouter::volumioPushQueue May 21 03:23:03 volumio squeezeboxserver[2799]: [03:23:03.284] sendSTAT:165 [0x62ef20]: STAT:[STMc] msplayed 0 May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: error: updateQueue error: null May 21 03:23:03 volumio volumio[1044]: error: updateQueue error: null May 21 03:23:03 volumio volumio[1044]: error: updateQueue error: null May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 8ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 7ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 6ms May 21 03:23:03 volumio volumio[1044]: info: Starting UPNP Playback May 21 03:23:03 volumio volumio[1044]: info: Preparing playback through UPNP May 21 03:23:03 volumio volumio[1044]: info: CoreCommandRouter::volumioGetState May 21 03:23:03 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:03 volumio volumio[1044]: info: CoreStateMachine::setConsumeUpdateService mpd May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 4ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 4ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 4ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 1ms May 21 03:23:03 volumio volumio[1044]: info: May 21 03:23:03 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:03 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:03 volumio volumio[1044]: info: ------------------------------ 1ms May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.700] AVTSetPlayMode:137 [0x6b6120]: uPNP set play mode (cookie 0xb3) May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.700] AVTPlay:123 [0x6b6120]: uPNP play (cookie 0xb4) May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.700] CtrlSetVolume:205 [0x6b6120]: uPNP volume 100 (cookie 0xb4) May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.703] output_http_thread:212 [0x62ef20]: got HTTP connection 17 May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.805] _output_new_stream:530 [0x62ef20]: FLAC-5 encoding r:44100 s:16 c:2 May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.805] output_http_thread:236 [0x62ef20]: got codec, drain is 131072 (waited 1850) May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.805] handle_http:501 [0x62ef20]: received GET /bridge-2.flac HTTP/1.1 May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.805] handle_http:504 [0x62ef20]: HTTP headers May 21 03:23:04 volumio squeezeboxserver[2799]: Host: 192.168.1.59:41111 May 21 03:23:04 volumio squeezeboxserver[2799]: User-Agent: Music Player Daemon 0.23.15 May 21 03:23:04 volumio squeezeboxserver[2799]: Accept: */* May 21 03:23:04 volumio squeezeboxserver[2799]: Icy-Metadata: 1 May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.806] handle_http:635 [0x62ef20]: responding: May 21 03:23:04 volumio squeezeboxserver[2799]: HTTP/1.1 200 OK May 21 03:23:04 volumio squeezeboxserver[2799]: Server: squeezebox-bridge May 21 03:23:04 volumio squeezeboxserver[2799]: Accept-Ranges: bytes May 21 03:23:04 volumio squeezeboxserver[2799]: Content-Type: audio/flac May 21 03:23:04 volumio squeezeboxserver[2799]: Connection: close May 21 03:23:04 volumio squeezeboxserver[2799]: Transfer-Encoding: chunked May 21 03:23:04 volumio squeezeboxserver[2799]: [1B blob data] May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.806] gain_and_fade:1097 [0x62ef20]: track start rate:44100 gain:65536 May 21 03:23:04 volumio volumio[1044]: info: May 21 03:23:04 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:04 volumio volumio[1044]: info: May 21 03:23:04 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:04 volumio volumio[1044]: info: May 21 03:23:04 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:04 volumio volumio[1044]: info: May 21 03:23:04 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:04 volumio volumio[1044]: info: May 21 03:23:04 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:04 volumio volumio[1044]: info: May 21 03:23:04 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand status took 16 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand status took 15 milliseconds May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand status took 8 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand status took 4 milliseconds May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand status took 9 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 8 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 5 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 6 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 5 milliseconds May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 4 milliseconds May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:04 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:04 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:04 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus stop May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:04 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:04 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:04 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:04 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:04 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:04 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:04 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:04 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:04 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:04 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"450 Kbps","isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:04 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:04 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:04 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:04 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"490 Kbps","isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:04 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:04 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: ------------------------------ 74ms May 21 03:23:04 volumio volumio[1044]: info: ------------------------------ 129ms May 21 03:23:04 volumio volumio[1044]: info: ------------------------------ 128ms May 21 03:23:04 volumio volumio[1044]: info: ------------------------------ 122ms May 21 03:23:04 volumio volumio[1044]: info: ------------------------------ 117ms May 21 03:23:04 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 103 milliseconds May 21 03:23:04 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:04 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:04 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:04 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"500 Kbps","isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:04 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:04 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio squeezeboxserver[2799]: [03:23:04.951] _SyncNotifState:711 Volumio-UPnP/AV: uPNP playing May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:04 volumio volumio[1044]: info: ------------------------------ 159ms May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:04 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:04 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:04 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:04 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:04 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:04 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:04 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:04 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:05 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:05 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:05 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:05 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:05 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:05 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:05 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:05 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:05 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:05 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:05 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:05 volumio squeezeboxserver[2799]: [03:23:05.202] ActionHandler:930 {0x6b6120]: expected URI detected http://192.168.1.59:41111/bridge-2.flac May 21 03:23:05 volumio squeezeboxserver[2799]: [03:23:05.203] sendSTAT:165 [0x62ef20]: STAT:[STMs] msplayed 1000 May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.399] output_flush:701 [0x62ef20]: joining thread index:2 (slot:0) May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.414] output_http_thread:367 [0x62ef20]: finishing thread index:2 (slot:0) - sent 13329423 bytes May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.415] output_http_thread:396 [0x62ef20]: exited thread index:2 (slot:0) May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.415] _output_end_stream:627 [0x62ef20]: finishing FLAC May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.415] sendSTAT:165 [0x62ef20]: STAT:[STMf] msplayed 0 May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.415] AVTStop:180 [0x6b6120]: uPNP stop (cookie 0x12d) May 21 03:23:44 volumio volumio[1044]: info: May 21 03:23:44 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:44 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:44 volumio volumio[1044]: info: May 21 03:23:44 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:44 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:44 volumio volumio[1044]: info: May 21 03:23:44 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:44 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:44 volumio volumio[1044]: info: sendMpdCommand status took 8 milliseconds May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:44 volumio volumio[1044]: info: sendMpdCommand status took 5 milliseconds May 21 03:23:44 volumio volumio[1044]: info: sendMpdCommand status took 4 milliseconds May 21 03:23:44 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 2 milliseconds May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:44 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:44 volumio volumio[1044]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:44 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::syncState stateService stop May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::stPlaybackTimer May 21 03:23:44 volumio volumio[1044]: info: ------------------------------ 47ms May 21 03:23:44 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 36 milliseconds May 21 03:23:44 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 37 milliseconds May 21 03:23:44 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:44 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:44 volumio volumio[1044]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:44 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::syncState stateService stop May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus stop May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: No code May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:44 volumio volumio[1044]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"東邪西毒","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:41111/bridge-2.flac","trackType":"flac"} May 21 03:23:44 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::syncState stateService stop May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus stop May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: No code May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:44 volumio volumio[1044]: info: ------------------------------ 125ms May 21 03:23:44 volumio volumio[1044]: info: ------------------------------ 119ms May 21 03:23:44 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:44 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:44 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:44 volumio squeezeboxserver[2799]: [03:23:44.626] _SyncNotifState:683 [0x6b6120]: uPNP stop May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.432] process_strm:234 [0x62ef20] strm command s May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.432] process_strm:304 [0x62ef20], strm s autostart: 3 transition period: 10 transition type: 0 codec: f May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.432] sendSTAT:165 [0x62ef20]: STAT:[STMf] msplayed 0 May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.441] output_start:158 [0x62ef20]: start thread index:3 (slot:0) May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.441] sq_callback:380 [0x6b6120]: May 21 03:23:46 volumio squeezeboxserver[2799]: artist:Yo-Yo Ma May 21 03:23:46 volumio squeezeboxserver[2799]: album:東邪西毒終極版 (電影原聲大碟) May 21 03:23:46 volumio squeezeboxserver[2799]: title:土黃用事(吳彤版) May 21 03:23:46 volumio squeezeboxserver[2799]: duration:195000 May 21 03:23:46 volumio squeezeboxserver[2799]: live_duration:-1 May 21 03:23:46 volumio squeezeboxserver[2799]: position:0 May 21 03:23:46 volumio squeezeboxserver[2799]: cover:http://192.168.1.59:9000/imageproxy/http%3A%2F%2Fresources.tidal.com%2Fimages%2F58e47714%2Fb455%2F4a10%2Fa3f4%2Ff0c215458b10%2F1280x1280.jpg/image.jpg May 21 03:23:46 volumio squeezeboxserver[2799]: index:0 May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.441] sq_callback:429 [0x6b6120]: set current URI (g:0) http://192.168.1.59:38805/bridge-3.flac May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.441] AVTSetURI:69 [0x6b6120]: uPNP setURI http://192.168.1.59:38805/bridge-3.flac (cookie 0x12f) May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.442] process_start:1268 [0x62ef20]: codec:f, ch:0, s:0, r:0 May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.442] output_http_thread:193 [0x62ef20]: thread index:3 (slot:0) started, listening socket 14 (cache:1) May 21 03:23:46 volumio volumio[1044]: info: Clearing queue after UPNP request May 21 03:23:46 volumio volumio[1044]: info: CoreStateMachine::ClearQueue May 21 03:23:46 volumio volumio[1044]: info: CoreStateMachine::stop May 21 03:23:46 volumio volumio[1044]: info: CoreStateMachine::setConsumeUpdateService undefined May 21 03:23:46 volumio volumio[1044]: info: CorePlayQueue::clearPlayQueue May 21 03:23:46 volumio volumio[1044]: info: CorePlayQueue::saveQueue May 21 03:23:46 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:46 volumio volumio[1044]: info: CoreCommandRouter::volumioPushQueue May 21 03:23:46 volumio squeezeboxserver[2799]: [03:23:46.759] sendSTAT:165 [0x62ef20]: STAT:[STMc] msplayed 0 May 21 03:23:46 volumio volumio[1044]: info: May 21 03:23:46 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:46 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:46 volumio volumio[1044]: info: May 21 03:23:46 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:46 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:46 volumio volumio[1044]: info: May 21 03:23:46 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:46 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:46 volumio volumio[1044]: error: updateQueue error: null May 21 03:23:46 volumio volumio[1044]: info: ------------------------------ 5ms May 21 03:23:46 volumio volumio[1044]: info: ------------------------------ 4ms May 21 03:23:46 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:46 volumio volumio[1044]: info: Starting UPNP Playback May 21 03:23:46 volumio volumio[1044]: info: Preparing playback through UPNP May 21 03:23:46 volumio volumio[1044]: info: CoreCommandRouter::volumioGetState May 21 03:23:46 volumio volumio[1044]: info: CorePlayQueue::getTrack 0 May 21 03:23:46 volumio volumio[1044]: info: CoreStateMachine::setConsumeUpdateService mpd May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 1ms May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 4ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 1ms May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 3ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 1ms May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces system playlist update May 21 03:23:47 volumio volumio[1044]: info: Ignoring MPD Status Update May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 2ms May 21 03:23:47 volumio volumio[1044]: info: ------------------------------ 1ms May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.936] AVTSetPlayMode:137 [0x6b6120]: uPNP set play mode (cookie 0x130) May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.936] AVTPlay:123 [0x6b6120]: uPNP play (cookie 0x131) May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.936] CtrlSetVolume:205 [0x6b6120]: uPNP volume 100 (cookie 0x131) May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.940] output_http_thread:212 [0x62ef20]: got HTTP connection 17 May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.990] _output_new_stream:530 [0x62ef20]: FLAC-5 encoding r:44100 s:16 c:2 May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.990] output_http_thread:236 [0x62ef20]: got codec, drain is 131072 (waited 1548) May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.991] handle_http:501 [0x62ef20]: received GET /bridge-3.flac HTTP/1.1 May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.991] handle_http:504 [0x62ef20]: HTTP headers May 21 03:23:47 volumio squeezeboxserver[2799]: Host: 192.168.1.59:38805 May 21 03:23:47 volumio squeezeboxserver[2799]: User-Agent: Music Player Daemon 0.23.15 May 21 03:23:47 volumio squeezeboxserver[2799]: Accept: */* May 21 03:23:47 volumio squeezeboxserver[2799]: Icy-Metadata: 1 May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.991] handle_http:635 [0x62ef20]: responding: May 21 03:23:47 volumio squeezeboxserver[2799]: HTTP/1.1 200 OK May 21 03:23:47 volumio squeezeboxserver[2799]: Server: squeezebox-bridge May 21 03:23:47 volumio squeezeboxserver[2799]: Accept-Ranges: bytes May 21 03:23:47 volumio squeezeboxserver[2799]: Content-Type: audio/flac May 21 03:23:47 volumio squeezeboxserver[2799]: Connection: close May 21 03:23:47 volumio squeezeboxserver[2799]: Transfer-Encoding: chunked May 21 03:23:47 volumio squeezeboxserver[2799]: [1B blob data] May 21 03:23:47 volumio squeezeboxserver[2799]: [03:23:47.991] gain_and_fade:1097 [0x62ef20]: track start rate:44100 gain:65536 May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:47 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:47 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:47 volumio volumio[1044]: info: May 21 03:23:47 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:47 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:47 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:48 volumio volumio[1044]: info: May 21 03:23:48 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:48 volumio volumio[1044]: info: May 21 03:23:48 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand status took 11 milliseconds May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand status took 10 milliseconds May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:48 volumio volumio[1044]: info: May 21 03:23:48 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand status took 8 milliseconds May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:48 volumio volumio[1044]: info: May 21 03:23:48 volumio volumio[1044]: ---------------------------- MPD announces state update: player May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::getState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand status May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand status took 11 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 11 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 10 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand status took 10 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 8 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand status took 4 milliseconds May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseState May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:48 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:48 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"土黃用事(吳彤版)","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:38805/bridge-3.flac","trackType":"flac"} May 21 03:23:48 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus stop May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:48 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:48 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"土黃用事(吳彤版)","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:38805/bridge-3.flac","trackType":"flac"} May 21 03:23:48 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:48 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:48 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:48 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"土黃用事(吳彤版)","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:38805/bridge-3.flac","trackType":"flac"} May 21 03:23:48 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:48 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: ------------------------------ 53ms May 21 03:23:48 volumio volumio[1044]: info: ------------------------------ 78ms May 21 03:23:48 volumio volumio[1044]: info: ------------------------------ 78ms May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 55 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 54 milliseconds May 21 03:23:48 volumio volumio[1044]: info: sendMpdCommand playlistinfo took 53 milliseconds May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:48 volumio volumio[1044]: verbose: ControllerMpd::parseTrackInfo May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:48 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:48 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"土黃用事(吳彤版)","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:38805/bridge-3.flac","trackType":"flac"} May 21 03:23:48 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:48 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:48 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:48 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"土黃用事(吳彤版)","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:38805/bridge-3.flac","trackType":"flac"} May 21 03:23:48 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:48 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: ControllerMpd::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::servicePushState May 21 03:23:48 volumio volumio[1044]: verbose: In UPNP mode May 21 03:23:48 volumio volumio[1044]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":195,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"681 Kbps","isStreaming":false,"title":"土黃用事(吳彤版)","artist":"Yo-Yo Ma","album":"東邪西毒終極版 (電影原聲大碟)","uri":"http://192.168.1.59:38805/bridge-3.flac","trackType":"flac"} May 21 03:23:48 volumio volumio[1044]: verbose: CURRENT POSITION 0 May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState stateService play May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::syncState currentStatus play May 21 03:23:48 volumio volumio[1044]: info: Received an update from plugin. extracting info from payload May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::pushState May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioPushState May 21 03:23:48 volumio volumio[1044]: info: ------------------------------ 136ms May 21 03:23:48 volumio volumio[1044]: info: ------------------------------ 131ms May 21 03:23:48 volumio volumio[1044]: info: ------------------------------ 128ms May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio volumio[1044]: info: CoreCommandRouter::volumioGetQueue May 21 03:23:48 volumio volumio[1044]: info: CoreStateMachine::getQueue May 21 03:23:48 volumio volumio[1044]: info: CorePlayQueue::getQueue May 21 03:23:48 volumio squeezeboxserver[2799]: [03:23:48.188] _SyncNotifState:711 Volumio-UPnP/AV: uPNP playing May 21 03:23:48 volumio squeezeboxserver[2799]: [03:23:48.440] ActionHandler:930 {0x6b6120]: expected URI detected http://192.168.1.59:38805/bridge-3.flac May 21 03:23:48 volumio squeezeboxserver[2799]: [03:23:48.440] sendSTAT:165 [0x62ef20]: STAT:[STMs] msplayed 1000 May 21 03:24:11 volumio nmbd[797]: [2025/05/21 03:24:11.086744, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 21 03:24:11 volumio nmbd[797]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.59 for name WORKGROUP<1d>. May 21 03:24:11 volumio nmbd[797]: This response was from IP 192.168.1.8, reporting an IP address of 192.168.1.8. May 21 03:24:22 volumio volumio[1044]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 21 03:24:22 volumio volumio[1044]: Error: connect ETIMEDOUT 108.160.170.45:443 May 21 03:24:22 volumio volumio[1044]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 21 03:24:22 volumio volumio[1044]: errno: -110, May 21 03:24:22 volumio volumio[1044]: code: 'ETIMEDOUT', May 21 03:24:22 volumio volumio[1044]: syscall: 'connect', May 21 03:24:22 volumio volumio[1044]: address: '108.160.170.45', May 21 03:24:22 volumio volumio[1044]: port: 443 May 21 03:24:22 volumio volumio[1044]: } May 21 03:24:22 volumio volumio[1044]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 21 03:24:23 volumio sudo[4227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-21 03:23 May 21 03:24:23 volumio sudo[4227]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"