-- Logs begin at Thu 2025-07-17 08:14:03 UTC, end at Thu 2025-07-17 08:26:26 UTC. -- Jul 17 08:25:25 opera systemd[1]: Started volumio-remote-updater-push.service. Jul 17 08:25:25 opera systemd[1]: Starting Multi-User System. Jul 17 08:25:25 opera systemd[1]: Reached target Multi-User System. Jul 17 08:25:25 opera systemd[1]: Starting Graphical Interface. Jul 17 08:25:25 opera systemd[1]: Reached target Graphical Interface. Jul 17 08:25:25 opera systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 17 08:25:25 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:25:25 opera systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 17 08:25:25 opera systemd[1]: Startup finished in 11.514s (kernel) + 2min 5.563s (userspace) = 2min 17.077s. Jul 17 08:26:06 opera kernel: usb 1-1.2: USB disconnect, device number 3 Jul 17 08:26:06 opera volumio[1427]: info: Jul 17 08:26:06 opera volumio[1427]: ---------------------------- MPD announces state update: player Jul 17 08:26:06 opera volumio[1427]: info: ControllerMpd::getState Jul 17 08:26:06 opera volumio[1427]: verbose: ControllerMpd::sendMpdCommand status Jul 17 08:26:06 opera volumio[1427]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 17 08:26:06 opera volumio[1427]: info: sendMpdCommand status took 6 milliseconds Jul 17 08:26:06 opera volumio[1427]: verbose: ControllerMpd::parseState Jul 17 08:26:06 opera volumio[1427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 08:26:06 opera volumio[1427]: info: sendMpdCommand clearerror took 3 milliseconds Jul 17 08:26:06 opera volumio[1427]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 17 08:26:06 opera volumio[1427]: verbose: ControllerMpd::parseTrackInfo Jul 17 08:26:06 opera volumio[1427]: info: ControllerMpd::pushState Jul 17 08:26:06 opera volumio[1427]: info: CoreCommandRouter::servicePushState Jul 17 08:26:06 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:06 opera volumio[1427]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104095,"duration":194,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"小城故事","artist":"赵鹏","album":"低音王朝I 你的眼神","uri":"USB/089B-1E33/试音/赵鹏 - 小城故事.ape","trackType":"ape"} Jul 17 08:26:06 opera volumio[1427]: verbose: CURRENT POSITION 0 Jul 17 08:26:06 opera volumio[1427]: info: CoreStateMachine::syncState stateService pause Jul 17 08:26:06 opera volumio[1427]: info: CoreStateMachine::syncState currentStatus play Jul 17 08:26:06 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:06 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:06 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:06 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:06 opera volumio[1427]: info: ------------------------------ 22ms Jul 17 08:26:06 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:06 opera volumio[1427]: info: Jul 17 08:26:06 opera volumio[1427]: ---------------------------- USB Audio Device Detached Jul 17 08:26:06 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 17 08:26:06 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:06 opera volumio[1427]: No protocol specified Jul 17 08:26:06 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:06 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 17 08:26:06 opera volumio[1427]: info: Stopping RAAT Plugin Jul 17 08:26:06 opera sudo[2265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Jul 17 08:26:06 opera sudo[2265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:06 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:06 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:06 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:06 opera sudo[2265]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:06 opera volumio[1427]: info: Raat Daemon stopped successfully Jul 17 08:26:06 opera kernel: usb 1-1.2: new high-speed USB device number 6 using dwc2 Jul 17 08:26:06 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3033 Jul 17 08:26:06 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:06 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:06 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:07 opera volumio[1427]: info: Jul 17 08:26:07 opera volumio[1427]: ---------------------------- USB Audio Device Attached Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::Close All Modals sent Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:07 opera volumio[1427]: info: Output device has changed, restarting MPD Jul 17 08:26:07 opera sudo[2282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 08:26:07 opera volumio[1427]: info: Output device has changed, restarting Shairport Sync Jul 17 08:26:07 opera sudo[2282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:07 opera sudo[2282]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:07 opera sudo[2286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 08:26:07 opera sudo[2286]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:07 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Jul 17 08:26:07 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jul 17 08:26:07 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 08:26:07 opera volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 08:26:07 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:07 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:07 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:07 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:07 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:07 opera volumio[1427]: info: MPD Permissions set Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:07 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:07 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:07 opera volumio[1427]: No protocol specified Jul 17 08:26:07 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 17 08:26:07 opera volumio[1427]: info: Starting Shairport Sync Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:07 opera volumio[1427]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 08:26:07 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:07 opera sudo[2319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 08:26:07 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:07 opera sudo[2321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:07 opera sudo[2319]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:07 opera sudo[2321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:07 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:07 opera sudo[2331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:07 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:07 opera sudo[2319]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:07 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:07 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:07 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:07 opera sudo[2321]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:07 opera sudo[2331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:07 opera volumio[1427]: info: Shairport-Sync Started Jul 17 08:26:07 opera volumio[2341]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:07 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:07 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:07 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:07 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:07 opera sudo[2331]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:07 opera volumio[2364]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:07 opera sudo[2361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:07 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:07 opera sudo[2286]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:07 opera sudo[2361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:07 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:07 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:07 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:07 opera sudo[2361]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:07 opera volumio[2364]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 17 08:26:07 opera sudo[2389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:07 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:07 opera sudo[2389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:08 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:08 opera sudo[2389]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:08 opera volumio[1427]: No protocol specified Jul 17 08:26:08 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 17 08:26:08 opera sudo[2406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:08 opera sudo[2406]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:08 opera volumio[1427]: error: updateQueue error: null Jul 17 08:26:08 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:08 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:08 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:08 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:08 opera sudo[2406]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:08 opera volumio[1427]: No protocol specified Jul 17 08:26:08 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:08 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:08 opera sudo[2427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:08 opera sudo[2427]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:08 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:08 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:08 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:08 opera volumio[1427]: No protocol specified Jul 17 08:26:08 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:08 opera sudo[2427]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:08 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:08 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:08 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:08 opera sudo[2446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:08 opera sudo[2446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:08 opera volumio[1427]: info: Executing endpoint restartRAATSocket Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jul 17 08:26:08 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:08 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:08 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:08 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:08 opera sudo[2446]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:08 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:08 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:08 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:08 opera volumio[1427]: info: Executing endpoint restartRAATSocket Jul 17 08:26:08 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jul 17 08:26:08 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 08:26:10 opera volumio[1427]: info: CoreStateMachine::getcurrentVolume Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 08:26:10 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:10 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:10 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:10 opera kernel: usb 1-1.2: USB disconnect, device number 6 Jul 17 08:26:10 opera volumio[1427]: info: Jul 17 08:26:10 opera volumio[1427]: ---------------------------- USB Audio Device Detached Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:10 opera volumio[1427]: No protocol specified Jul 17 08:26:10 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 17 08:26:10 opera volumio[1427]: info: Stopping RAAT Plugin Jul 17 08:26:10 opera sudo[2478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Jul 17 08:26:10 opera sudo[2478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:10 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:10 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:10 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:10 opera sudo[2478]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:10 opera volumio[1427]: info: Raat Daemon stopped successfully Jul 17 08:26:10 opera kernel: usb 1-1.2: new high-speed USB device number 7 using dwc2 Jul 17 08:26:10 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=000a Jul 17 08:26:10 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:10 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:10 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:10 opera volumio[1427]: info: Jul 17 08:26:10 opera volumio[1427]: ---------------------------- USB Audio Device Attached Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 08:26:10 opera volumio[1427]: No protocol specified Jul 17 08:26:10 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::Close All Modals sent Jul 17 08:26:10 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:10 opera volumio[1427]: info: Output device has changed, restarting MPD Jul 17 08:26:10 opera volumio[1427]: info: Output device has changed, restarting Shairport Sync Jul 17 08:26:10 opera sudo[2494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 08:26:10 opera sudo[2494]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:10 opera sudo[2494]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:10 opera sudo[2496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 08:26:10 opera sudo[2496]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:10 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:10 opera volumio[1427]: No protocol specified Jul 17 08:26:10 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:10 opera volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 08:26:10 opera volumio[1427]: No protocol specified Jul 17 08:26:10 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:10 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 17 08:26:10 opera volumio[1427]: No protocol specified Jul 17 08:26:10 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:11 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Jul 17 08:26:11 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 08:26:11 opera volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 08:26:11 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:11 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:11 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:11 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:11 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera volumio[1427]: info: MPD Permissions set Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:11 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:11 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 17 08:26:11 opera volumio[1427]: info: Starting Shairport Sync Jul 17 08:26:11 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:11 opera sudo[2531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 08:26:11 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:11 opera sudo[2531]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera sudo[2535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera sudo[2535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:11 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:11 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:11 opera sudo[2531]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:11 opera sudo[2540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:11 opera sudo[2540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera volumio[1427]: info: Shairport-Sync Started Jul 17 08:26:11 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:11 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:11 opera sudo[2535]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:11 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:11 opera sudo[2540]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:11 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:11 opera volumio[2568]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:11 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:11 opera sudo[2579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:11 opera volumio[2568]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 17 08:26:11 opera sudo[2579]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:11 opera sudo[2579]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera sudo[2585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:11 opera sudo[2585]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:11 opera sudo[2496]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:11 opera sudo[2585]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera sudo[2611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera sudo[2611]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:11 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:11 opera sudo[2611]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:11 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:11 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: error: updateQueue error: null Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:11 opera sudo[2636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:11 opera sudo[2636]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:11 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:11 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:11 opera sudo[2636]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: No protocol specified Jul 17 08:26:11 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:11 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:11 opera sudo[2654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:11 opera volumio[1427]: info: Executing endpoint restartRAATSocket Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jul 17 08:26:11 opera sudo[2654]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:11 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:11 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:11 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:11 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:11 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:11 opera sudo[2654]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:11 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:11 opera volumio[1427]: info: Executing endpoint restartRAATSocket Jul 17 08:26:11 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jul 17 08:26:11 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:12 opera kernel: usb 1-1.2: USB disconnect, device number 7 Jul 17 08:26:12 opera volumio[1427]: info: Jul 17 08:26:12 opera volumio[1427]: ---------------------------- USB Audio Device Detached Jul 17 08:26:12 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 17 08:26:12 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:12 opera volumio[1427]: No protocol specified Jul 17 08:26:12 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:12 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 17 08:26:12 opera volumio[1427]: info: Stopping RAAT Plugin Jul 17 08:26:12 opera sudo[2686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Jul 17 08:26:12 opera sudo[2686]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:12 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:12 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:12 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:12 opera sudo[2686]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:12 opera volumio[1427]: info: Raat Daemon stopped successfully Jul 17 08:26:12 opera kernel: usb 1-1.2: new high-speed USB device number 8 using dwc2 Jul 17 08:26:12 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3033 Jul 17 08:26:12 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:12 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:12 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:13 opera volumio[1427]: info: Jul 17 08:26:13 opera volumio[1427]: ---------------------------- USB Audio Device Attached Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::Close All Modals sent Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:13 opera volumio[1427]: info: Output device has changed, restarting MPD Jul 17 08:26:13 opera volumio[1427]: info: Output device has changed, restarting Shairport Sync Jul 17 08:26:13 opera sudo[2701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 08:26:13 opera sudo[2701]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera sudo[2701]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera sudo[2703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 08:26:13 opera sudo[2703]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:13 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Jul 17 08:26:13 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 08:26:13 opera volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 08:26:13 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:13 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:13 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:13 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:13 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:13 opera volumio[1427]: info: MPD Permissions set Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:13 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:13 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 08:26:13 opera volumio[1427]: info: CoreStateMachine::getcurrentVolume Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 08:26:13 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:13 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:13 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:13 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:13 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:13 opera volumio[1427]: info: Starting Shairport Sync Jul 17 08:26:13 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:13 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:13 opera sudo[2738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 08:26:13 opera sudo[2738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:13 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:13 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:13 opera sudo[2738]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:13 opera sudo[2746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:13 opera sudo[2743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:13 opera volumio[1427]: info: Shairport-Sync Started Jul 17 08:26:13 opera sudo[2743]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera sudo[2746]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:13 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:13 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:13 opera sudo[2743]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera sudo[2746]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:13 opera volumio[2771]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:13 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:13 opera sudo[2783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:13 opera sudo[2786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:13 opera sudo[2783]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera sudo[2786]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera volumio[2771]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:13 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:13 opera sudo[2786]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera sudo[2783]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera volumio[1427]: No protocol specified Jul 17 08:26:13 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera sudo[2807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 17 08:26:13 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:13 opera sudo[2807]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:13 opera sudo[2703]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:13 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:13 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:13 opera sudo[2807]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:13 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:13 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:13 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:14 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:14 opera volumio[1427]: No protocol specified Jul 17 08:26:14 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:14 opera volumio[1427]: error: updateQueue error: null Jul 17 08:26:14 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:14 opera sudo[2840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:14 opera sudo[2840]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:14 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:14 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:14 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:14 opera sudo[2840]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:14 opera volumio[1427]: No protocol specified Jul 17 08:26:14 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:14 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:14 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:14 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:14 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:14 opera sudo[2858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:14 opera sudo[2858]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:14 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:14 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:14 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:14 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:14 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:14 opera sudo[2858]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:14 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:14 opera volumio[1427]: info: Executing endpoint restartRAATSocket Jul 17 08:26:14 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jul 17 08:26:14 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:15 opera volumio[1427]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 08:26:15 opera volumio[1427]: info: CoreStateMachine::getcurrentVolume Jul 17 08:26:15 opera volumio[1427]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 08:26:15 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:15 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:15 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:15 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:15 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:16 opera kernel: usb 1-1.2: USB disconnect, device number 8 Jul 17 08:26:16 opera volumio[1427]: info: Jul 17 08:26:16 opera volumio[1427]: ---------------------------- USB Audio Device Detached Jul 17 08:26:16 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 17 08:26:16 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:16 opera volumio[1427]: No protocol specified Jul 17 08:26:16 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:16 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 17 08:26:16 opera volumio[1427]: info: Stopping RAAT Plugin Jul 17 08:26:16 opera sudo[2894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Jul 17 08:26:16 opera sudo[2894]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:16 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:16 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:16 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:16 opera sudo[2894]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:16 opera volumio[1427]: info: Raat Daemon stopped successfully Jul 17 08:26:16 opera kernel: usb 1-1.2: new high-speed USB device number 9 using dwc2 Jul 17 08:26:16 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=000a Jul 17 08:26:16 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:16 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:16 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:17 opera kernel: usb 1-1.2: 1:1: cannot set freq 768000 (v2): err -71 Jul 17 08:26:17 opera kernel: usb 1-1.2: parse_audio_format_rates_v2(): unable to find clock source (clock -71) Jul 17 08:26:17 opera kernel: usb 1-1.2: parse_audio_format_rates_v2(): unable to find clock source (clock -71) Jul 17 08:26:17 opera volumio[1427]: info: Jul 17 08:26:17 opera volumio[1427]: ---------------------------- USB Audio Device Attached Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::Close All Modals sent Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:17 opera volumio[1427]: info: Output device has changed, restarting MPD Jul 17 08:26:17 opera volumio[1427]: info: Output device has changed, restarting Shairport Sync Jul 17 08:26:17 opera sudo[2909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 08:26:17 opera sudo[2909]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:17 opera sudo[2909]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:17 opera sudo[2912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 08:26:17 opera sudo[2912]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:17 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 17 08:26:17 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:17 opera kernel: usb 1-1.2: USB disconnect, device number 9 Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:17 opera volumio[1427]: Invalid card number. Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 08:26:17 opera volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 08:26:17 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:17 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:17 opera systemd-udevd[2886]: Failed to apply ACL on /dev/snd/pcmC5D0p: No such file or directory Jul 17 08:26:17 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:17 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:17 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:17 opera volumio[1427]: info: MPD Permissions set Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:17 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:17 opera volumio[1427]: Invalid card number. Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 17 08:26:17 opera volumio[1427]: info: Starting Shairport Sync Jul 17 08:26:17 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:17 opera volumio[1427]: info: Jul 17 08:26:17 opera volumio[1427]: ---------------------------- USB Audio Device Detached Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:17 opera kernel: usb 1-1.2: new high-speed USB device number 10 using dwc2 Jul 17 08:26:17 opera sudo[2950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:17 opera sudo[2949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 08:26:17 opera sudo[2950]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:17 opera sudo[2949]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:17 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:17 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:17 opera systemd[1]: volspotconnect2.service start request repeated too quickly, refusing to start. Jul 17 08:26:17 opera systemd[1]: Failed to start Volspotconnect2 Daemon. Jul 17 08:26:17 opera systemd[1]: Unit volspotconnect2.service entered failed state. Jul 17 08:26:17 opera sudo[2950]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 17 08:26:17 opera volumio[1427]: info: Stopping RAAT Plugin Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:17 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:17 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:17 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:17 opera sudo[2949]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:17 opera sudo[2965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Jul 17 08:26:17 opera volumio[1427]: [SpotifyConnect] Error: Command failed: /usr/bin/sudo /bin/systemctl restart volspotconnect2.service Jul 17 08:26:17 opera volumio[1427]: Job for volspotconnect2.service failed. See 'systemctl status volspotconnect2.service' and 'journalctl -xn' for details. Jul 17 08:26:17 opera volumio[1427]: at ChildProcess.exithandler (child_process.js:275:12) Jul 17 08:26:17 opera volumio[1427]: at emitTwo (events.js:126:13) Jul 17 08:26:17 opera volumio[1427]: at ChildProcess.emit (events.js:214:7) Jul 17 08:26:17 opera volumio[1427]: at maybeClose (internal/child_process.js:925:16) Jul 17 08:26:17 opera volumio[1427]: at Socket.stream.socket.on (internal/child_process.js:346:11) Jul 17 08:26:17 opera volumio[1427]: at emitOne (events.js:116:13) Jul 17 08:26:17 opera volumio[1427]: at Socket.emit (events.js:211:7) Jul 17 08:26:17 opera volumio[1427]: at Pipe._handle.close [as _onclose] (net.js:567:12) Jul 17 08:26:17 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3033 Jul 17 08:26:17 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:17 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:17 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:17 opera sudo[2965]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:17 opera sudo[2965]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:17 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:17 opera volumio[1427]: info: Shairport-Sync Started Jul 17 08:26:17 opera volumio[1427]: info: Raat Daemon stopped successfully Jul 17 08:26:17 opera sudo[2991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:17 opera sudo[2991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:17 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:17 opera systemd[1]: volspotconnect2.service start request repeated too quickly, refusing to start. Jul 17 08:26:17 opera systemd[1]: Failed to start Volspotconnect2 Daemon. Jul 17 08:26:17 opera sudo[2991]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:17 opera volumio[1427]: [SpotifyConnect] Unable to start Daemon: Error: Command failed: /usr/bin/sudo /bin/systemctl start volspotconnect2.service Jul 17 08:26:17 opera volumio[1427]: Job for volspotconnect2.service failed. See 'systemctl status volspotconnect2.service' and 'journalctl -xn' for details. Jul 17 08:26:17 opera volumio[1427]: at ChildProcess.exithandler (child_process.js:275:12) Jul 17 08:26:17 opera volumio[1427]: at emitTwo (events.js:126:13) Jul 17 08:26:17 opera volumio[1427]: at ChildProcess.emit (events.js:214:7) Jul 17 08:26:17 opera volumio[1427]: at maybeClose (internal/child_process.js:925:16) Jul 17 08:26:17 opera volumio[1427]: at Process.ChildProcess._handle.onexit (internal/child_process.js:209:5) Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: Configured Audio card not found, not starting RAAT Jul 17 08:26:17 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:17 opera sudo[2912]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:17 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:17 opera volumio[1427]: No protocol specified Jul 17 08:26:17 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:17 opera volumio[1427]: info: Configured Audio card not found, not starting RAAT Jul 17 08:26:17 opera volumio[1427]: error: updateQueue error: null Jul 17 08:26:18 opera volumio[1427]: info: Jul 17 08:26:18 opera volumio[1427]: ---------------------------- USB Audio Device Attached Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::Close All Modals sent Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:18 opera volumio[1427]: info: Output device has changed, restarting MPD Jul 17 08:26:18 opera volumio[1427]: info: Output device has changed, restarting Shairport Sync Jul 17 08:26:18 opera sudo[3024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 08:26:18 opera sudo[3027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 08:26:18 opera sudo[3027]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:18 opera sudo[3024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera sudo[3024]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:18 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Jul 17 08:26:18 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 08:26:18 opera volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 08:26:18 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:18 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:18 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:18 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:18 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:18 opera volumio[1427]: info: MPD Permissions set Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:18 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:18 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:18 opera volumio[1427]: Invalid card number. Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 17 08:26:18 opera kernel: usb 1-1.2: USB disconnect, device number 10 Jul 17 08:26:18 opera volumio[1427]: info: Starting Shairport Sync Jul 17 08:26:18 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:18 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:18 opera sudo[3065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:18 opera sudo[3065]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera sudo[3067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:18 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:18 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera sudo[3064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera sudo[3065]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera volumio[3073]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:18 opera sudo[3064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera sudo[3067]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:18 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:18 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:18 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:18 opera sudo[3064]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:18 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:18 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:18 opera sudo[3067]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera volumio[3094]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E9%B9%8F/%E4%BD%8E%E9%9F%B3%E7%8E%8B%E6%9C%9DI%20%E4%BD%A0%E7%9A%84%E7%9C%BC%E7%A5%9E/5338fd81-b563-43ef-953d-0977f93c7798.jpg' Jul 17 08:26:18 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E9%B9%8F/%E4%BD%8E%E9%9F%B3%E7%8E%8B%E6%9C%9DI%20%E4%BD%A0%E7%9A%84%E7%9C%BC%E7%A5%9E/5338fd81-b563-43ef-953d-0977f93c7798.jpg' Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:18 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:18 opera volumio[1427]: info: Shairport-Sync Started Jul 17 08:26:18 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:18 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:18 opera sudo[3027]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera sudo[3124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera sudo[3124]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera volumio[1427]: info: Jul 17 08:26:18 opera volumio[1427]: ---------------------------- USB Audio Device Detached Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:18 opera volumio[3094]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 17 08:26:18 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:18 opera sudo[3124]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jul 17 08:26:18 opera volumio[1427]: info: Stopping RAAT Plugin Jul 17 08:26:18 opera kernel: usb 1-1.2: new high-speed USB device number 11 using dwc2 Jul 17 08:26:18 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:18 opera sudo[3139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 17 08:26:18 opera sudo[3139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:18 opera sudo[3139]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera sudo[3144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:18 opera sudo[3144]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:18 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:18 opera volumio[1427]: info: Raat Daemon stopped successfully Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:18 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:18 opera sudo[3144]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:18 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=000a Jul 17 08:26:18 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:18 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:18 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: Configured Audio card not found, not starting RAAT Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:18 opera volumio[1427]: No protocol specified Jul 17 08:26:18 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:18 opera volumio[1427]: info: Configured Audio card not found, not starting RAAT Jul 17 08:26:18 opera volumio[1427]: error: updateQueue error: null Jul 17 08:26:18 opera volumio[1427]: [SpotifyConnect] Vollibrespot Daemon Started Jul 17 08:26:18 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: Configured Audio card not found, not starting RAAT Jul 17 08:26:19 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E6%83%85%E4%BA%BA/1e6933fc-5eb1-4907-b46d-62e1e419e3eb.jpg' Jul 17 08:26:19 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E6%80%9D%E6%83%85/6dfcbc09-9c37-4337-82b0-bfccf67f7862.jpg' Jul 17 08:26:19 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E6%92%A9%E4%BA%BA/15998ccb-0b47-488a-8fd7-d8d1468384d3.jpg' Jul 17 08:26:19 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%8F%A6%E4%B8%80%E7%A7%8D%E6%83%85%E6%84%9F/3354f6fe-575f-499f-b770-39013adffed6.jpg' Jul 17 08:26:19 opera volumio[1427]: info: Jul 17 08:26:19 opera volumio[1427]: ---------------------------- USB Audio Device Attached Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::Close All Modals sent Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:19 opera volumio[1427]: info: Output device has changed, restarting MPD Jul 17 08:26:19 opera volumio[1427]: info: Output device has changed, restarting Shairport Sync Jul 17 08:26:19 opera sudo[3172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 08:26:19 opera sudo[3175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 08:26:19 opera sudo[3172]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:19 opera sudo[3175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:19 opera sudo[3172]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jul 17 08:26:19 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:19 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: Device 5 does not have any Mixer Control Available, setting a softvol device Jul 17 08:26:19 opera volumio[1427]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 08:26:19 opera volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 08:26:19 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:19 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:19 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:19 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:19 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:19 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:19 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:19 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:19 opera volumio[1427]: info: MPD Permissions set Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:19 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioGetState Jul 17 08:26:19 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 08:26:19 opera volumio[1427]: No protocol specified Jul 17 08:26:19 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jul 17 08:26:19 opera volumio[1427]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E8%AF%B1%E6%83%91/f258715a-f252-4da4-a3ce-73d0b5748dd4.jpg' Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 08:26:19 opera volumio[1427]: info: CoreStateMachine::getcurrentVolume Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 08:26:19 opera volumio[1427]: info: CoreStateMachine::pushState Jul 17 08:26:19 opera volumio[1427]: info: CorePlayQueue::getTrack 0 Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::volumioPushState Jul 17 08:26:19 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 08:26:19 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:19 opera volumio[1427]: info: Updating RAAT Signal Path Jul 17 08:26:19 opera volumio[1427]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jul 17 08:26:19 opera volumio[1427]: info: Starting Shairport Sync Jul 17 08:26:19 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:19 opera sudo[3210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 08:26:19 opera volumio[1427]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 17 08:26:19 opera sudo[3210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera sudo[3215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:20 opera sudo[3215]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:20 opera sudo[3218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 17 08:26:20 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:20 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:20 opera sudo[3218]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:20 opera sudo[3210]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:20 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:20 opera volumio[1427]: info: Shairport-Sync Started Jul 17 08:26:20 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:20 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:20 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:20 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:20 opera sudo[3218]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera sudo[3215]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera volumio[3247]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:20 opera volumio[1427]: No protocol specified Jul 17 08:26:20 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:20 opera volumio[3247]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 17 08:26:20 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera sudo[3175]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 17 08:26:20 opera sudo[3261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:20 opera sudo[3261]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 08:26:20 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:20 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 17 08:26:20 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:20 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:20 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:20 opera sudo[3261]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera volumio[1427]: [SpotifyConnect] null Jul 17 08:26:20 opera volumio[1427]: info: Raat Daemon started successfully Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:20 opera sudo[3293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:20 opera sudo[3286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jul 17 08:26:20 opera sudo[3293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera sudo[3286]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:20 opera sudo[3293]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:20 opera sudo[3286]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera volumio[1427]: No protocol specified Jul 17 08:26:20 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:20 opera volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jul 17 08:26:20 opera sudo[3311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jul 17 08:26:20 opera sudo[3311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 08:26:20 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:20 opera volumio[1427]: No protocol specified Jul 17 08:26:20 opera volumio[1427]: xcb_connection_has_error() returned true Jul 17 08:26:20 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:20 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:20 opera sudo[3311]: pam_unix(sudo:session): session closed for user root Jul 17 08:26:20 opera volumio[1427]: error: updateQueue error: null Jul 17 08:26:20 opera volumio[1427]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 17 08:26:20 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:20 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:20 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:24 opera kernel: usb 1-1.2: USB disconnect, device number 11 Jul 17 08:26:24 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:24 opera systemd[1]: Stopped RAAT DAEMON. Jul 17 08:26:24 opera kernel: usb 1-1.2: new high-speed USB device number 12 using dwc2 Jul 17 08:26:24 opera kernel: usb 1-1.2: New USB device found, idVendor=20b1, idProduct=3033 Jul 17 08:26:24 opera kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Jul 17 08:26:24 opera kernel: usb 1-1.2: Product: Gustard USB Audio 2.0 Jul 17 08:26:24 opera kernel: usb 1-1.2: Manufacturer: Gustard Jul 17 08:26:25 opera systemd[1]: Stopping Music Player Daemon... Jul 17 08:26:25 opera systemd[1]: Starting Music Player Daemon... Jul 17 08:26:25 opera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:25 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 17 08:26:25 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 08:26:25 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:25 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:25 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:25 opera volumio[3452]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:25 opera systemd[1]: Stopping Volspotconnect2 Daemon... Jul 17 08:26:25 opera systemd[1]: Starting Volspotconnect2 Daemon... Jul 17 08:26:25 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:25 opera volumio[3461]: vollibrespot v0.1.9 c98fd5d 2019-11-08 (librespot 4674946 2019-11-08) -- Built On 2019-11-08 Jul 17 08:26:25 opera volumio[3461]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 17 08:26:25 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:25 opera systemd[1]: Started Music Player Daemon. Jul 17 08:26:25 opera systemd[1]: Started Volspotconnect2 Daemon. Jul 17 08:26:25 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:25 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:25 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:25 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:25 opera systemd[1]: Started RAAT DAEMON. Jul 17 08:26:26 opera systemd[1]: Stopping RAAT DAEMON... Jul 17 08:26:26 opera systemd[1]: Starting RAAT DAEMON... Jul 17 08:26:26 opera systemd[1]: Started RAAT DAEMON. PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"