-- Logs begin at Wed 2024-10-09 07:13:13 KST, end at Wed 2024-10-09 19:28:54 KST. -- Oct 09 19:27:00 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:00 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104532 Oct 09 19:27:00 main-speaker volumio[877]: info: VolumeController::SetAlsaVolume- Oct 09 19:27:00 main-speaker volumio[877]: info: CoreStateMachine::pushState Oct 09 19:27:00 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 19:27:00 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushState Oct 09 19:27:08 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:10 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:10 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104553 Oct 09 19:27:14 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:15 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:15 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104535 Oct 09 19:27:19 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:20 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:20 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104536 Oct 09 19:27:27 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:28 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:28 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104596 Oct 09 19:27:29 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 19:27:29 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 19:27:29 main-speaker volumio[877]: info: Discovery: Getting this device information Oct 09 19:27:29 main-speaker volumio[877]: info: CoreCommandRouter::volumioGetState Oct 09 19:27:29 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 19:27:33 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:33 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:34 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104562 Oct 09 19:27:40 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:41 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:41 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104564 Oct 09 19:27:48 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:50 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:50 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104558 Oct 09 19:27:54 main-speaker volumio[877]: info: Listing playlists Oct 09 19:27:55 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:27:55 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104559 Oct 09 19:27:59 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 19:27:59 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 19:27:59 main-speaker volumio[877]: info: Discovery: Getting this device information Oct 09 19:27:59 main-speaker volumio[877]: info: CoreCommandRouter::volumioGetState Oct 09 19:27:59 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 19:28:08 main-speaker volumio[877]: info: Listing playlists Oct 09 19:28:09 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:28:09 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104531 Oct 09 19:28:14 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:14 main-speaker volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::ClearQueue Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::stop Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::serviceStop Oct 09 19:28:14 main-speaker volumio[877]: info: CoreCommandRouter::serviceStop Oct 09 19:28:14 main-speaker volumio[877]: info: Airplay Stop Oct 09 19:28:14 main-speaker volumio[877]: info: Stopping Airplay Playback and sending pause command to client via USR2 Oct 09 19:28:14 main-speaker volumio[877]: info: CorePlayQueue::clearPlayQueue Oct 09 19:28:14 main-speaker volumio[877]: info: CorePlayQueue::saveQueue Oct 09 19:28:14 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushQueue Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::addQueueItems Oct 09 19:28:14 main-speaker volumio[877]: info: CorePlayQueue::addQueueItems Oct 09 19:28:14 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:14 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:14 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:14 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushQueue Oct 09 19:28:14 main-speaker volumio[877]: info: CorePlayQueue::saveQueue Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::updateTrackBlock Oct 09 19:28:14 main-speaker volumio[877]: info: CorePlayQueue::getTrackBlock Oct 09 19:28:14 main-speaker volumio[877]: info: CoreCommandRouter::volumioPlay Oct 09 19:28:14 main-speaker volumio[877]: verbose: UNSET VOLATILE: Service: airplay_emulation Oct 09 19:28:14 main-speaker volumio[877]: info: Stopping Airplay Playback and sending pause command to client via USR2 Oct 09 19:28:14 main-speaker sudo[21736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 4767 Oct 09 19:28:14 main-speaker sudo[21736]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::play index 0 Oct 09 19:28:14 main-speaker sudo[21736]: pam_unix(sudo:session): session closed for user root Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::stop Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::play index undefined Oct 09 19:28:14 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:14 main-speaker volumio[877]: info: CorePlayQueue::getTrack 0 Oct 09 19:28:14 main-speaker volumio[877]: info: Shairport-Sync paused with USR2 Oct 09 19:28:14 main-speaker sudo[21740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 4767 Oct 09 19:28:14 main-speaker sudo[21740]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:28:14 main-speaker sudo[21740]: pam_unix(sudo:session): session closed for user root Oct 09 19:28:14 main-speaker volumio[877]: info: Shairport-Sync paused with USR2 Oct 09 19:28:15 main-speaker volumio[877]: info: Restarting Shairport-Sync after stop Oct 09 19:28:15 main-speaker volumio[877]: info: Restarting Shairport-Sync after stop Oct 09 19:28:15 main-speaker sudo[21743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 09 19:28:15 main-speaker sudo[21743]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:28:15 main-speaker sudo[21746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 09 19:28:15 main-speaker systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 09 19:28:15 main-speaker sudo[21746]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 19:28:15 main-speaker shairport-sync[4767]: {"time":1728468722644,"response":"stopAirplayPlayback Success"} Oct 09 19:28:15 main-speaker systemd[1]: shairport-sync.service: Succeeded. Oct 09 19:28:15 main-speaker systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 09 19:28:15 main-speaker systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 09 19:28:15 main-speaker sudo[21743]: pam_unix(sudo:session): session closed for user root Oct 09 19:28:15 main-speaker volumio[877]: info: Shairport-Sync retarted Oct 09 19:28:15 main-speaker systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 09 19:28:15 main-speaker systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 09 19:28:15 main-speaker systemd[1]: shairport-sync.service: Succeeded. Oct 09 19:28:15 main-speaker systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 09 19:28:15 main-speaker systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 09 19:28:15 main-speaker sudo[21746]: pam_unix(sudo:session): session closed for user root Oct 09 19:28:15 main-speaker volumio[877]: info: Shairport-Sync retarted Oct 09 19:28:19 main-speaker volumio[877]: info: Listing playlists Oct 09 19:28:20 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , explodeUri Oct 09 19:28:20 main-speaker volumio[877]: error: Could not add to playlist: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:26 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:26 main-speaker volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::ClearQueue Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::stop Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:26 main-speaker volumio[877]: info: CorePlayQueue::clearPlayQueue Oct 09 19:28:26 main-speaker volumio[877]: info: CorePlayQueue::saveQueue Oct 09 19:28:26 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushQueue Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::addQueueItems Oct 09 19:28:26 main-speaker volumio[877]: info: CorePlayQueue::addQueueItems Oct 09 19:28:26 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104606 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104606 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104534 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104534 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104539 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104539 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104594 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104594 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104590 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104590 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104549 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104549 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104575 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104575 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104616 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104616 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104532 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104532 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104538 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104538 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104574 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104574 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104565 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104565 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104573 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104573 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104546 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104546 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104576 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104576 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104553 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104553 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104547 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104547 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104561 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104561 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104597 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104597 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104614 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104614 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104591 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104591 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104535 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104535 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104536 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104536 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104621 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104621 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104541 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104541 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104578 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104578 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104628 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104628 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104540 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104540 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104567 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104567 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104626 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104626 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104613 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104613 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104610 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104610 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104596 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104596 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104617 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104617 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104588 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104588 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104623 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104623 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104572 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104572 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104557 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104557 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104584 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104584 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104560 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104560 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104562 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104562 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104558 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104558 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104577 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104577 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104564 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104564 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104559 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104559 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104604 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104604 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104568 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104568 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104607 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104607 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104551 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104551 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104619 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104619 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104620 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104620 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104537 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104537 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104612 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104612 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104629 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104629 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104550 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104550 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104544 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104544 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104593 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104593 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104605 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104605 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104582 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104582 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104533 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104533 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104531 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104531 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104552 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104552 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104545 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104545 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104548 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104548 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104601 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104601 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104569 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104569 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104615 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104615 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104580 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104580 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104566 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104566 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104611 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104611 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104571 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104571 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104608 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104608 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104554 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104554 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104563 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104563 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104556 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104556 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104602 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104602 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104581 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104581 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104592 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104592 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104625 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104625 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104543 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104543 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104579 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104579 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104603 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104603 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104624 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104624 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104589 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104589 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104627 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104627 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104622 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104622 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104587 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104587 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104585 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104585 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104586 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104586 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104609 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104609 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104630 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104630 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104555 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104555 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104583 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104583 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104595 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104595 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104618 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104618 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104599 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104599 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104600 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104600 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104570 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104570 Oct 09 19:28:26 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104598 Oct 09 19:28:26 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104598 Oct 09 19:28:26 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushQueue Oct 09 19:28:26 main-speaker volumio[877]: info: CorePlayQueue::saveQueue Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::updateTrackBlock Oct 09 19:28:26 main-speaker volumio[877]: info: CorePlayQueue::getTrackBlock Oct 09 19:28:26 main-speaker volumio[877]: info: CoreCommandRouter::volumioPlay Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::play index 65 Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::stop Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::play index undefined Oct 09 19:28:26 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:26 main-speaker volumio[877]: info: CorePlayQueue::getTrack 65 Oct 09 19:28:28 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:28 main-speaker volumio[877]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::ClearQueue Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::stop Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:28 main-speaker volumio[877]: info: CorePlayQueue::clearPlayQueue Oct 09 19:28:28 main-speaker volumio[877]: info: CorePlayQueue::saveQueue Oct 09 19:28:28 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushQueue Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::addQueueItems Oct 09 19:28:28 main-speaker volumio[877]: info: CorePlayQueue::addQueueItems Oct 09 19:28:28 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104606 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104606 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104534 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104534 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104539 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104539 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104594 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104594 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104590 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104590 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104549 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104549 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104575 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104575 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104616 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104616 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104532 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104532 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104538 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104538 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104574 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104574 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104565 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104565 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104573 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104573 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104546 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104546 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104576 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104576 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104553 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104553 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104547 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104547 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104561 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104561 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104597 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104597 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104614 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104614 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104591 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104591 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104535 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104535 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104536 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104536 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104621 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104621 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104541 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104541 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104578 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104578 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104628 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104628 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104540 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104540 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104567 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104567 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104626 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104626 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104613 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104613 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104610 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104610 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104596 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104596 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104617 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104617 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104588 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104588 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104623 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104623 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104572 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104572 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104557 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104557 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104584 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104584 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104560 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104560 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104562 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104562 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104558 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104558 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104577 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104577 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104564 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104564 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104559 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104559 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104604 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104604 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104568 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104568 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104607 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104607 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104551 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104551 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104619 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104619 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104620 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104620 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104537 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104537 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104612 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104612 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104629 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104629 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104550 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104550 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104544 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104544 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104593 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104593 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104605 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104605 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104582 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104582 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104533 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104533 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104531 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104531 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104552 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104552 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104545 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104545 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104548 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104548 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104601 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104601 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104542 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104569 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104569 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104615 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104615 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104580 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104580 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104566 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104566 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104611 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104611 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104571 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104571 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104608 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104608 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104554 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104554 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104563 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104563 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104556 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104556 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104602 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104602 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104581 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104581 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104592 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104592 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104625 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104625 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104543 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104543 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104579 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104579 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104603 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104603 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104624 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104624 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104589 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104589 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104627 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104627 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104622 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104622 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104587 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104587 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104585 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104585 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104586 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104586 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104609 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104609 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104630 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104630 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104555 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104555 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104583 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104583 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104595 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104595 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104618 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104618 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104599 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104599 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104600 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104600 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104570 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104570 Oct 09 19:28:28 main-speaker volumio[877]: info: Adding Item to queue: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104598 Oct 09 19:28:28 main-speaker volumio[877]: info: Using cached record of: upnp/http://192.168.29.225:50001/ContentDirectory/control@22$@104598 Oct 09 19:28:28 main-speaker volumio[877]: info: CoreCommandRouter::volumioPushQueue Oct 09 19:28:28 main-speaker volumio[877]: info: CorePlayQueue::saveQueue Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::updateTrackBlock Oct 09 19:28:28 main-speaker volumio[877]: info: CorePlayQueue::getTrackBlock Oct 09 19:28:28 main-speaker volumio[877]: info: CoreCommandRouter::volumioPlay Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::play index 65 Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::stop Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::play index undefined Oct 09 19:28:28 main-speaker volumio[877]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 19:28:28 main-speaker volumio[877]: info: CorePlayQueue::getTrack 65 Oct 09 19:28:29 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 19:28:29 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 19:28:29 main-speaker volumio[877]: info: Discovery: Getting this device information Oct 09 19:28:29 main-speaker volumio[877]: info: CoreCommandRouter::volumioGetState Oct 09 19:28:29 main-speaker volumio[877]: info: CorePlayQueue::getTrack 0 Oct 09 19:28:29 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 19:28:34 main-speaker volumio[877]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 19:28:37 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:37 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:38 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:38 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:39 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:39 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:40 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:40 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:42 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:42 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:45 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:46 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@99953 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@101024 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100676 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95929 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95943 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@102953 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@93419 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95956 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@99666 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@93611 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100655 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98371 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98369 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98370 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98372 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98373 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95847 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@96143 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100599 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@102565 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84653 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84649 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84652 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84651 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84650 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81926 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81916 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81923 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81925 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81918 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81927 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81924 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81917 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81922 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81919 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81921 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81920 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81915 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81911 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81907 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81904 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81912 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81910 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81908 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81905 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81913 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81909 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81914 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81906 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@96447 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@101756 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100028 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@99914 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@102761 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@103542 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104179 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104279 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@92761 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104481 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104606 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104706 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@103921 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@103576 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104388 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104075 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84854 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97808 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97819 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97817 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97812 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97814 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97822 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97809 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97815 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97810 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97811 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97813 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97820 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97816 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97825 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97818 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97826 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97823 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97821 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97824 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75553 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75546 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75552 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75551 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75543 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75547 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75556 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75548 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75549 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75545 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75542 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75540 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75550 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75544 Oct 09 19:28:46 main-speaker volumio[877]: info: Preloading song: upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75555 Oct 09 19:28:46 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@99953 in service upnp_browser Oct 09 19:28:46 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@101024 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100676 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95929 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95943 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@102953 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@93419 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95956 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@99666 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@93611 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100655 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98371 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98369 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98370 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98372 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@98373 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@95847 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@96143 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100599 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@102565 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84653 in service upnp_browser Oct 09 19:28:47 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84649 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84652 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84651 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84650 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81926 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81916 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81923 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81925 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81918 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81927 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81924 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81917 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81922 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81919 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81921 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81920 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81915 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81911 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81907 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81904 in service upnp_browser Oct 09 19:28:48 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81912 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81910 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81908 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81905 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81913 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81909 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81914 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@81906 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@96447 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@101756 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@100028 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@99914 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@102761 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@103542 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104179 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104279 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@92761 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104481 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104606 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104706 in service upnp_browser Oct 09 19:28:49 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@103921 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@103576 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104388 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@104075 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@84854 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97808 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97819 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97817 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97812 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97814 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97822 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97809 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97815 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97810 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97811 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97813 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97820 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97816 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97825 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97818 in service upnp_browser Oct 09 19:28:50 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97826 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97823 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97821 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@97824 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75553 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75546 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75552 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75551 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Exploding uri upnp/http://192.168.29.225:50001/ContentDirectory/control@23$@75543 in service upnp_browser Oct 09 19:28:51 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:52 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:52 main-speaker volumio[877]: info: Preload queue cleared Oct 09 19:28:53 main-speaker volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 09 19:28:54 main-speaker volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 19:28:54 main-speaker volumio[877]: TypeError: Cannot read property 'length' of undefined Oct 09 19:28:54 main-speaker volumio[877]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 09 19:28:54 main-speaker volumio[877]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 09 19:28:54 main-speaker volumio[877]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 09 19:28:54 main-speaker volumio[877]: at Parser.emit (events.js:315:20) Oct 09 19:28:54 main-speaker volumio[877]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 09 19:28:54 main-speaker volumio[877]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 09 19:28:54 main-speaker volumio[877]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 09 19:28:54 main-speaker volumio[877]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 09 19:28:54 main-speaker volumio[877]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 09 19:28:54 main-speaker volumio[877]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 09 19:28:54 main-speaker volumio[877]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 09 19:28:54 main-speaker volumio[877]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 09 19:28:54 main-speaker volumio[877]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 09 19:28:54 main-speaker volumio[877]: at IncomingMessage.emit (events.js:327:22) Oct 09 19:28:54 main-speaker volumio[877]: at endReadableNT (internal/streams/readable.js:1327:12) Oct 09 19:28:54 main-speaker volumio[877]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 09 19:28:54 main-speaker volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 19:28:54 main-speaker sudo[21827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 19:27 Oct 09 19:28:54 main-speaker sudo[21827]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"