-- Logs begin at Tue 2024-11-19 19:04:20 EST, end at Fri 2024-11-22 19:19:56 EST. -- Nov 22 19:18:05 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 22 19:18:46 volumio volumio[971]: info: Clearing queue after UPNP request Nov 22 19:18:47 volumio volumio[971]: info: CoreStateMachine::ClearQueue Nov 22 19:18:47 volumio volumio[971]: info: CoreStateMachine::stop Nov 22 19:18:47 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 19:18:47 volumio volumio[971]: info: CorePlayQueue::clearPlayQueue Nov 22 19:18:47 volumio volumio[971]: info: CorePlayQueue::saveQueue Nov 22 19:18:47 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:18:47 volumio volumio[971]: info: CoreCommandRouter::volumioPushQueue Nov 22 19:18:47 volumio volumio[971]: error: Upnp client error: Error: This socket has been ended by the other party Nov 22 19:18:56 volumio kernel: usb 1-1.4: new high-speed USB device number 5 using xhci_hcd Nov 22 19:18:56 volumio kernel: usb 1-1.4: New USB device found, idVendor=2616, idProduct=0113, bcdDevice= 6.f2 Nov 22 19:18:56 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Nov 22 19:18:56 volumio kernel: usb 1-1.4: Product: PS Audio USB Audio 2.0 Nov 22 19:18:56 volumio kernel: usb 1-1.4: Manufacturer: PS Audio Nov 22 19:18:56 volumio kernel: usb 1-1.4: 1:3 : unsupported format bits 0x100000000 Nov 22 19:18:56 volumio volumio[971]: info: Nov 22 19:18:56 volumio volumio[971]: ---------------------------- USB Audio Device Attached Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::Close All Modals sent Nov 22 19:18:56 volumio volumio[971]: info: Preparing to save Alsa Options, stopping services first Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:18:56 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::volumioPause Nov 22 19:18:56 volumio volumio[971]: info: CoreStateMachine::pause Nov 22 19:18:56 volumio volumio[971]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"PS Audio USB Audio 2.0","alsacard":"P20"},"i2s":false} Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 22 19:18:56 volumio volumio[971]: info: Setting mixer Mix 1 for card PS Audio USB Audio 2.0 Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 22 19:18:56 volumio volumio[971]: info: Updating Volume Controller Parameters: Device: 5 Name: PS Audio USB Audio 2.0 Mixer: Mix 1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 22 19:18:56 volumio volumio[971]: info: Disabling external Volume Control Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 19:18:56 volumio volumio[971]: info: Preparing to generate the ALSA configuration file Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 22 19:18:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 22 19:18:57 volumio volumio[971]: info: Asound.conf file unchanged, so no further update is needed Nov 22 19:18:57 volumio volumio[971]: info: Output device has changed, restarting MPD Nov 22 19:18:57 volumio sudo[10080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 22 19:18:57 volumio sudo[10080]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 22 19:18:57 volumio volumio[971]: info: Output device has changed, restarting Shairport Sync Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 22 19:18:57 volumio sudo[10080]: pam_unix(sudo:session): session closed for user root Nov 22 19:18:57 volumio sudo[10083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 22 19:18:57 volumio sudo[10083]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 22 19:18:57 volumio systemd[1]: Stopping Music Player Daemon... Nov 22 19:18:57 volumio volumio[971]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 22 19:18:57 volumio volumio[971]: info: MPD Permissions set Nov 22 19:18:57 volumio volumio[971]: info: VolumeController:: Volume=100 Mute =false Nov 22 19:18:57 volumio volumio[971]: info: CoreStateMachine::pushState Nov 22 19:18:57 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:18:57 volumio systemd[1]: mpd.service: Succeeded. Nov 22 19:18:57 volumio systemd[1]: Stopped Music Player Daemon. Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 22 19:18:57 volumio volumio[971]: info: Starting Shairport Sync Nov 22 19:18:57 volumio sudo[10094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 22 19:18:57 volumio sudo[10094]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 22 19:18:57 volumio systemd[1]: Starting Music Player Daemon... Nov 22 19:18:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 22 19:18:57 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 22 19:18:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 22 19:18:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 22 19:18:57 volumio sudo[10094]: pam_unix(sudo:session): session closed for user root Nov 22 19:18:57 volumio volumio[971]: info: Shairport-Sync Started Nov 22 19:18:57 volumio sudo[10088]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 22 19:18:57 volumio sudo[10088]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 22 19:18:57 volumio sudo[10088]: pam_unix(sudo:session): session closed for user root Nov 22 19:18:57 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Nov 22 19:18:57 volumio mpd[10100]: Nov 22 19:18 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 22 19:18:57 volumio systemd[1]: Started Music Player Daemon. Nov 22 19:18:57 volumio sudo[10083]: pam_unix(sudo:session): session closed for user root Nov 22 19:18:57 volumio volumio[971]: error: updateQueue error: null Nov 22 19:19:00 volumio volumio[971]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 22 19:19:00 volumio volumio[971]: info: CoreStateMachine::getcurrentVolume Nov 22 19:19:00 volumio volumio[971]: info: CoreCommandRouter::volumioRetrievevolume Nov 22 19:19:00 volumio volumio[971]: info: VolumeController:: Volume=100 Mute =false Nov 22 19:19:00 volumio volumio[971]: info: CoreStateMachine::pushState Nov 22 19:19:00 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:00 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:00 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Nov 22 19:19:00 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Nov 22 19:19:00 volumio volumio[971]: info: CoreCommandRouter::volumioRetrievevolume Nov 22 19:19:01 volumio volumio[971]: info: VolumeController:: Volume=100 Mute =false Nov 22 19:19:01 volumio volumio[971]: info: CoreStateMachine::pushState Nov 22 19:19:01 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:01 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:05 volumio volumio[971]: info: Clearing queue after UPNP request Nov 22 19:19:06 volumio volumio[971]: info: CoreStateMachine::ClearQueue Nov 22 19:19:06 volumio volumio[971]: info: CoreStateMachine::stop Nov 22 19:19:06 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 19:19:06 volumio volumio[971]: info: CorePlayQueue::clearPlayQueue Nov 22 19:19:06 volumio volumio[971]: info: CorePlayQueue::saveQueue Nov 22 19:19:06 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:06 volumio volumio[971]: info: CoreCommandRouter::volumioPushQueue Nov 22 19:19:06 volumio volumio[971]: error: Upnp client error: Error: This socket has been ended by the other party Nov 22 19:19:07 volumio volumio[971]: info: Clearing queue after UPNP request Nov 22 19:19:08 volumio volumio[971]: info: CoreStateMachine::ClearQueue Nov 22 19:19:08 volumio volumio[971]: info: CoreStateMachine::stop Nov 22 19:19:08 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 19:19:08 volumio volumio[971]: info: CorePlayQueue::clearPlayQueue Nov 22 19:19:08 volumio volumio[971]: info: CorePlayQueue::saveQueue Nov 22 19:19:08 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:08 volumio volumio[971]: info: CoreCommandRouter::volumioPushQueue Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: error: updateQueue error: null Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:08 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:08 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:08 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:08 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:08 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:08 volumio volumio[971]: info: Nov 22 19:19:08 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:08 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:08 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:10 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:10 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:10 volumio volumio[971]: info: Consume mode Nov 22 19:19:10 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:10 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:11 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:11 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:11 volumio volumio[971]: info: Consume mode Nov 22 19:19:11 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:11 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 3ms Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:11 volumio volumio[971]: info: Nov 22 19:19:11 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:11 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:11 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:11 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:11 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:11 volumio volumio[971]: info: Consume mode Nov 22 19:19:11 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:11 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces state update: player Nov 22 19:19:12 volumio volumio[971]: info: ControllerMpd::getState Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces state update: player Nov 22 19:19:12 volumio volumio[971]: info: sendMpdCommand status took 25 milliseconds Nov 22 19:19:12 volumio volumio[971]: info: ControllerMpd::getState Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::parseState Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 19:19:12 volumio volumio[971]: info: sendMpdCommand status took 2 milliseconds Nov 22 19:19:12 volumio volumio[971]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::parseState Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Nov 22 19:19:12 volumio volumio[971]: info: ControllerMpd::pushState Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::servicePushState Nov 22 19:19:12 volumio volumio[971]: verbose: In UPNP mode Nov 22 19:19:12 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Girl From Ipanema","artist":"Stan Getz, Antonio Carlos Jobim (Composer), Norman Gimbel, ComposerLyricist - Astrud Gilberto, Vocals, AssociatedPerformer - Vinicius De Moraes, ComposerLyricist - António Carlos Jobim, Piano, AssociatedPerformer, ComposerLyricist - Joao Gilberto, Guitar, Vocals, AssociatedPerformer - Stan Getz, Tenor Saxophone, MainArtist, AssociatedPerformer - Tommy Williams, Bass, AssociatedPerformer - Milton Banana, Drums, AssociatedPerformer - Creed Taylor, Producer (Performer)","album":"Getz/Gilberto","uri":"http://192.168.254.134:57645/proxy/qobuz/9479A915C6AED3781D80BDD370FB17DC.flac","trackType":"qobuz"} Nov 22 19:19:12 volumio volumio[971]: verbose: CURRENT POSITION 0 Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 34ms Nov 22 19:19:12 volumio volumio[971]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 19:19:12 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Nov 22 19:19:12 volumio volumio[971]: info: ControllerMpd::pushState Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::servicePushState Nov 22 19:19:12 volumio volumio[971]: verbose: In UPNP mode Nov 22 19:19:12 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Girl From Ipanema","artist":"Stan Getz, Antonio Carlos Jobim (Composer), Norman Gimbel, ComposerLyricist - Astrud Gilberto, Vocals, AssociatedPerformer - Vinicius De Moraes, ComposerLyricist - António Carlos Jobim, Piano, AssociatedPerformer, ComposerLyricist - Joao Gilberto, Guitar, Vocals, AssociatedPerformer - Stan Getz, Tenor Saxophone, MainArtist, AssociatedPerformer - Tommy Williams, Bass, AssociatedPerformer - Milton Banana, Drums, AssociatedPerformer - Creed Taylor, Producer (Performer)","album":"Getz/Gilberto","uri":"http://192.168.254.134:57645/proxy/qobuz/9479A915C6AED3781D80BDD370FB17DC.flac","trackType":"qobuz"} Nov 22 19:19:12 volumio volumio[971]: verbose: CURRENT POSITION 0 Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus play Nov 22 19:19:12 volumio volumio[971]: info: Received an update from plugin. extracting info from payload Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::pushState Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::pushState Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 15ms Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::volumioGetQueue Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::getQueue Nov 22 19:19:12 volumio volumio[971]: info: CorePlayQueue::getQueue Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::volumioGetQueue Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::getQueue Nov 22 19:19:12 volumio volumio[971]: info: CorePlayQueue::getQueue Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:12 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:12 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:12 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:12 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:12 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:12 volumio volumio[971]: info: Nov 22 19:19:12 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:12 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:12 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:12 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:12 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:12 volumio volumio[971]: info: Consume mode Nov 22 19:19:12 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:12 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 3ms Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 4ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:13 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:13 volumio volumio[971]: info: Consume mode Nov 22 19:19:13 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:13 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:13 volumio volumio[971]: info: Nov 22 19:19:13 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:13 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:13 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:13 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:13 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:13 volumio volumio[971]: info: Consume mode Nov 22 19:19:13 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:13 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:14 volumio volumio[971]: info: Nov 22 19:19:14 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:14 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:14 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:14 volumio volumio[971]: info: Nov 22 19:19:14 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:14 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:14 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:14 volumio volumio[971]: info: Nov 22 19:19:14 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:14 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:14 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:14 volumio volumio[971]: info: Nov 22 19:19:14 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:14 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:14 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:14 volumio volumio[971]: info: Nov 22 19:19:14 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:14 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:14 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:14 volumio volumio[971]: info: Nov 22 19:19:14 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:14 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:14 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:14 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:14 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:14 volumio volumio[971]: info: Consume mode Nov 22 19:19:14 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:14 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:15 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:15 volumio volumio[971]: info: Consume mode Nov 22 19:19:15 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:15 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:15 volumio volumio[971]: info: Nov 22 19:19:15 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:15 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:15 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:15 volumio volumio[971]: info: Starting UPNP Playback Nov 22 19:19:15 volumio volumio[971]: info: Preparing playback through UPNP Nov 22 19:19:15 volumio volumio[971]: info: Consume mode Nov 22 19:19:15 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:15 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 19:19:16 volumio volumio[971]: info: Nov 22 19:19:16 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:16 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:16 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:16 volumio volumio[971]: info: Nov 22 19:19:16 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:16 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:16 volumio volumio[971]: info: Nov 22 19:19:16 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:16 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:16 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:16 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:16 volumio volumio[971]: info: Nov 22 19:19:16 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:16 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:16 volumio volumio[971]: info: Nov 22 19:19:16 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:16 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:16 volumio volumio[971]: info: ------------------------------ 2ms Nov 22 19:19:16 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:16 volumio volumio[971]: info: Nov 22 19:19:16 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:16 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:16 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:33 volumio volumio[971]: info: Nov 22 19:19:33 volumio volumio[971]: ---------------------------- MPD announces state update: player Nov 22 19:19:33 volumio volumio[971]: info: ControllerMpd::getState Nov 22 19:19:33 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Nov 22 19:19:33 volumio volumio[971]: info: Clearing queue after UPNP request Nov 22 19:19:33 volumio volumio[971]: info: sendMpdCommand status took 1 milliseconds Nov 22 19:19:33 volumio volumio[971]: verbose: ControllerMpd::parseState Nov 22 19:19:33 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 19:19:33 volumio volumio[971]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 22 19:19:33 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Nov 22 19:19:33 volumio volumio[971]: info: ControllerMpd::pushState Nov 22 19:19:33 volumio volumio[971]: info: CoreCommandRouter::servicePushState Nov 22 19:19:33 volumio volumio[971]: info: CoreStateMachine::pushState Nov 22 19:19:33 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:33 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:33 volumio volumio[971]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Girl From Ipanema","artist":"Stan Getz, Antonio Carlos Jobim (Composer), Norman Gimbel, ComposerLyricist - Astrud Gilberto, Vocals, AssociatedPerformer - Vinicius De Moraes, ComposerLyricist - António Carlos Jobim, Piano, AssociatedPerformer, ComposerLyricist - Joao Gilberto, Guitar, Vocals, AssociatedPerformer - Stan Getz, Tenor Saxophone, MainArtist, AssociatedPerformer - Tommy Williams, Bass, AssociatedPerformer - Milton Banana, Drums, AssociatedPerformer - Creed Taylor, Producer (Performer)","album":"Getz/Gilberto","uri":"http://192.168.254.134:57645/proxy/qobuz/9479A915C6AED3781D80BDD370FB17DC.flac","trackType":"qobuz"} Nov 22 19:19:33 volumio volumio[971]: verbose: CURRENT POSITION 0 Nov 22 19:19:33 volumio volumio[971]: info: CoreStateMachine::syncState stateService stop Nov 22 19:19:33 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus play Nov 22 19:19:33 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:33 volumio volumio[971]: info: CoreStateMachine::stPlaybackTimer Nov 22 19:19:33 volumio volumio[971]: info: ------------------------------ 9ms Nov 22 19:19:33 volumio volumio[971]: info: CoreCommandRouter::volumioGetQueue Nov 22 19:19:33 volumio volumio[971]: info: CoreStateMachine::getQueue Nov 22 19:19:33 volumio volumio[971]: info: CorePlayQueue::getQueue Nov 22 19:19:34 volumio volumio[971]: info: CoreStateMachine::ClearQueue Nov 22 19:19:34 volumio volumio[971]: info: CoreStateMachine::stop Nov 22 19:19:34 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 19:19:34 volumio volumio[971]: info: CorePlayQueue::clearPlayQueue Nov 22 19:19:34 volumio volumio[971]: info: CorePlayQueue::saveQueue Nov 22 19:19:34 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Nov 22 19:19:34 volumio volumio[971]: info: CoreCommandRouter::volumioPushQueue Nov 22 19:19:34 volumio volumio[971]: info: Nov 22 19:19:34 volumio volumio[971]: ---------------------------- MPD announces system playlist update Nov 22 19:19:34 volumio volumio[971]: info: Ignoring MPD Status Update Nov 22 19:19:34 volumio volumio[971]: error: updateQueue error: null Nov 22 19:19:34 volumio volumio[971]: info: ------------------------------ 1ms Nov 22 19:19:49 volumio volumio[971]: verbose: New Socket.io Connection to 192.168.254.66 from 192.168.254.134 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::volumioGetVisibleSources Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:49 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 22 19:19:49 volumio volumio[971]: info: Received Get System Info Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 22 19:19:49 volumio volumio[971]: info: Discovery: Getting this device information Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:49 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Nov 22 19:19:49 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Nov 22 19:19:49 volumio volumio[971]: info: Listing playlists Nov 22 19:19:49 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 22 19:19:50 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 22 19:19:51 volumio volumio[971]: info: Disabling MyMusic plugin upnp Nov 22 19:19:51 volumio sudo[10290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Nov 22 19:19:51 volumio sudo[10290]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 22 19:19:51 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Nov 22 19:19:51 volumio volumio[971]: error: Upnp client error: Error: This socket has been ended by the other party Nov 22 19:19:54 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 22 19:19:56 volumio volumio[971]: info: Enabling MyMusic plugin upnp Nov 22 19:19:56 volumio volumio[971]: info: Enabling plugin upnp Nov 22 19:19:56 volumio volumio[971]: info: Loading plugin "upnp"... Nov 22 19:19:56 volumio volumio[971]: info: [1732321196230] Starting Upmpd Daemon Nov 22 19:19:56 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 22 19:19:56 volumio volumio[971]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 22 19:19:56 volumio volumio[971]: Error: listen EADDRINUSE: address already in use :::6599 Nov 22 19:19:56 volumio volumio[971]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 22 19:19:56 volumio volumio[971]: at listenInCluster (net.js:1366:12) Nov 22 19:19:56 volumio volumio[971]: at Server.listen (net.js:1452:7) Nov 22 19:19:56 volumio volumio[971]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Nov 22 19:19:56 volumio volumio[971]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Nov 22 19:19:56 volumio volumio[971]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Nov 22 19:19:56 volumio volumio[971]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 22 19:19:56 volumio volumio[971]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Nov 22 19:19:56 volumio volumio[971]: code: 'EADDRINUSE', Nov 22 19:19:56 volumio volumio[971]: errno: -98, Nov 22 19:19:56 volumio volumio[971]: syscall: 'listen', Nov 22 19:19:56 volumio volumio[971]: address: '::', Nov 22 19:19:56 volumio volumio[971]: port: 6599 Nov 22 19:19:56 volumio volumio[971]: } Nov 22 19:19:56 volumio volumio[971]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 22 19:19:56 volumio sudo[10315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-22 19:18 Nov 22 19:19:56 volumio sudo[10315]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"