-- Logs begin at Mon 2024-04-29 09:59:21 UTC, end at Wed 2024-05-01 04:25:50 UTC. -- May 01 04:24:08 volumio volumio[955]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 01 04:24:08 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 01 04:24:08 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 04:24:08 volumio volumio[955]: info: Disabling I2S DAC: May 01 04:24:08 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC May 01 04:24:08 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 04:24:08 volumio volumio[955]: info: Output device has changed, restarting MPD May 01 04:24:08 volumio volumio[955]: info: Output device has changed, restarting Shairport Sync May 01 04:24:08 volumio sudo[3478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 01 04:24:08 volumio sudo[3478]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:08 volumio sudo[3480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 01 04:24:08 volumio sudo[3480]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:08 volumio sudo[3478]: pam_unix(sudo:session): session closed for user root May 01 04:24:08 volumio systemd[1]: Stopping Music Player Daemon... May 01 04:24:08 volumio volumio[955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 01 04:24:08 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 04:24:08 volumio volumio[955]: info: Found match in Cards Database: setting mixer PCM for card Audio Jack May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 01 04:24:09 volumio volumio[955]: info: Updating Volume Controller Parameters: Device: 0 Name: Audio Jack Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 04:24:09 volumio volumio[955]: error: Upnp client error: Error: This socket has been ended by the other party May 01 04:24:09 volumio volumio[955]: info: MPD Permissions set May 01 04:24:09 volumio volumio[955]: error: Raspberry PI Jack Output Enabled May 01 04:24:09 volumio volumio[955]: error: Raspberry PI Jack Output Enabled May 01 04:24:09 volumio sudo[3501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store May 01 04:24:09 volumio sudo[3501]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:09 volumio sudo[3503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio sudo[3503]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:09 volumio systemd[1]: Starting Music Player Daemon... May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:09 volumio sudo[3501]: pam_unix(sudo:session): session closed for user root May 01 04:24:09 volumio sudo[3520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 01 04:24:09 volumio sudo[3520]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:09 volumio sudo[3520]: pam_unix(sudo:session): session closed for user root May 01 04:24:09 volumio volumio[955]: info: No Overlays Loaded May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 04:24:09 volumio volumio[955]: error: Alsa Settings successfully stored May 01 04:24:09 volumio volumio[955]: info: VolumeController:: Volume=100 Mute =false May 01 04:24:09 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:09 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:09 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:09 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:09 volumio volumio[955]: info: Starting Shairport Sync May 01 04:24:09 volumio sudo[3537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:09 volumio sudo[3537]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:09 volumio sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 01 04:24:09 volumio sudo[3537]: pam_unix(sudo:session): session closed for user root May 01 04:24:09 volumio sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 01 04:24:09 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 01 04:24:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 01 04:24:09 volumio sudo[3541]: pam_unix(sudo:session): session closed for user root May 01 04:24:09 volumio volumio[955]: info: Shairport-Sync Started May 01 04:24:10 volumio volumio[955]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 04:24:10 volumio volumio[955]: info: Output device has changed, restarting MPD May 01 04:24:10 volumio volumio[955]: info: Output device has changed, restarting Shairport Sync May 01 04:24:10 volumio sudo[3570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 01 04:24:10 volumio sudo[3570]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:10 volumio sudo[3572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 01 04:24:10 volumio sudo[3570]: pam_unix(sudo:session): session closed for user root May 01 04:24:10 volumio volumio[955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 01 04:24:10 volumio sudo[3572]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:10 volumio systemd[1]: Stopping Music Player Daemon... May 01 04:24:10 volumio sudo[3503]: pam_unix(sudo:session): session closed for user root May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 04:24:10 volumio volumio[955]: info: Found match in Cards Database: setting mixer PCM for card Audio Jack May 01 04:24:10 volumio systemd[1]: Starting Music Player Daemon... May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 01 04:24:10 volumio volumio[955]: info: Updating Volume Controller Parameters: Device: 0 Name: Audio Jack Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 04:24:10 volumio volumio[955]: info: MPD Permissions set May 01 04:24:10 volumio volumio[955]: error: Raspberry PI Jack Output Enabled May 01 04:24:10 volumio volumio[955]: error: Alsa Settings successfully stored May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:10 volumio sudo[3597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store May 01 04:24:10 volumio sudo[3597]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 01 04:24:10 volumio sudo[3597]: pam_unix(sudo:session): session closed for user root May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 04:24:10 volumio volumio[955]: error: Alsa Settings successfully stored May 01 04:24:10 volumio volumio[955]: info: Starting Shairport Sync May 01 04:24:10 volumio volumio[955]: info: VolumeController:: Volume=100 Mute =false May 01 04:24:10 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:10 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:10 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:10 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:10 volumio sudo[3615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 01 04:24:10 volumio kernel: usb 1-1.2: USB disconnect, device number 6 May 01 04:24:11 volumio sudo[3615]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:11 volumio sudo[3617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:11 volumio sudo[3617]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:11 volumio sudo[3617]: pam_unix(sudo:session): session closed for user root May 01 04:24:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 01 04:24:11 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 01 04:24:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 01 04:24:11 volumio sudo[3615]: pam_unix(sudo:session): session closed for user root May 01 04:24:11 volumio volumio[955]: info: Shairport-Sync Started May 01 04:24:11 volumio udisks-glue[561]: Device file /dev/sda1 unmounted from /media/32GB May 01 04:24:11 volumio udisks-glue[561]: Device file /dev/sda1 removed May 01 04:24:11 volumio udisks-glue[561]: Device file /dev/sda removed May 01 04:24:11 volumio ntfs-3g[3192]: Unmounting /dev/sda1 (32GB) May 01 04:24:11 volumio ntfs-3g[3192]: Failed to sync device /dev/sda1: Input/output error May 01 04:24:11 volumio ntfs-3g[3192]: Failed to close volume /dev/sda1: Input/output error May 01 04:24:11 volumio sudo[3480]: pam_unix(sudo:session): session closed for user root May 01 04:24:11 volumio sudo[3572]: pam_unix(sudo:session): session closed for user root May 01 04:24:11 volumio systemd[1]: Started Music Player Daemon. May 01 04:24:11 volumio udisks-glue[561]: Updating DB (#1) ... May 01 04:24:11 volumio udisks-glue[561]: volume:100% repeat: off random: off single: off consume: off May 01 04:24:11 volumio volumio[955]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 01 04:24:11 volumio volumio[955]: info: CoreStateMachine::getcurrentVolume May 01 04:24:11 volumio volumio[955]: info: CoreCommandRouter::volumioRetrievevolume May 01 04:24:11 volumio udisks-glue[561]: Updating DB (#2) ... May 01 04:24:11 volumio udisks-glue[561]: volume:100% repeat: off random: off single: off consume: off May 01 04:24:11 volumio volumio[955]: error: MPD error: false == true May 01 04:24:11 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:11 volumio volumio[955]: info: May 01 04:24:11 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:24:11 volumio volumio[955]: info: sending command... May 01 04:24:11 volumio volumio[955]: info: ControllerMpd::getState May 01 04:24:11 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:11 volumio volumio[955]: info: sending command... May 01 04:24:11 volumio volumio[955]: info: May 01 04:24:11 volumio volumio[955]: info: parsing response... May 01 04:24:11 volumio volumio[955]: info: parsing response... May 01 04:24:11 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:11 volumio kernel: usb 1-1.2: new high-speed USB device number 7 using dwc_otg May 01 04:24:12 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:24:12 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:12 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:12 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:24:12 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:12 volumio sudo[3667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:12 volumio sudo[3667]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:12 volumio sudo[3667]: pam_unix(sudo:session): session closed for user root May 01 04:24:12 volumio volumio[955]: info: No code May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:12 volumio sudo[3675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:12 volumio sudo[3675]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:12 volumio sudo[3675]: pam_unix(sudo:session): session closed for user root May 01 04:24:12 volumio sudo[3681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:12 volumio volumio[955]: info: ------------------------------ 782ms May 01 04:24:12 volumio sudo[3681]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:12 volumio sudo[3681]: pam_unix(sudo:session): session closed for user root May 01 04:24:12 volumio kernel: usb 1-1.2: device descriptor read/64, error -71 May 01 04:24:12 volumio volumio[955]: info: VolumeController:: Volume=100 Mute =false May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::updateTrackBlock May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrackBlock May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioRetrievevolume May 01 04:24:12 volumio sudo[3695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:12 volumio sudo[3695]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:12 volumio sudo[3695]: pam_unix(sudo:session): session closed for user root May 01 04:24:12 volumio volumio[955]: info: VolumeController:: Volume=100 Mute =false May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:12 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:12 volumio sudo[3706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:12 volumio sudo[3706]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:12 volumio sudo[3706]: pam_unix(sudo:session): session closed for user root May 01 04:24:12 volumio volumio[955]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 01 04:24:12 volumio volumio[955]: info: CoreStateMachine::getcurrentVolume May 01 04:24:13 volumio volumio[955]: info: CoreCommandRouter::volumioRetrievevolume May 01 04:24:13 volumio volumio[955]: info: VolumeController:: Volume=100 Mute =false May 01 04:24:13 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:13 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:13 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:13 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:13 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:13 volumio volumio[955]: info: CoreStateMachine::updateTrackBlock May 01 04:24:13 volumio volumio[955]: info: CorePlayQueue::getTrackBlock May 01 04:24:13 volumio volumio[955]: info: CoreCommandRouter::volumioRetrievevolume May 01 04:24:13 volumio sudo[3717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:13 volumio sudo[3717]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:13 volumio sudo[3717]: pam_unix(sudo:session): session closed for user root May 01 04:24:13 volumio volumio[955]: info: VolumeController:: Volume=100 Mute =false May 01 04:24:13 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:13 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:13 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:13 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:13 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:13 volumio sudo[3728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:13 volumio sudo[3728]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:13 volumio sudo[3728]: pam_unix(sudo:session): session closed for user root May 01 04:24:14 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 04:24:16 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: info: CoreCommandRouter::volumioPlay May 01 04:24:19 volumio volumio[955]: UNSET VOLATILE May 01 04:24:19 volumio volumio[955]: info: CoreStateMachine::play index undefined May 01 04:24:19 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:24:19 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:19 volumio volumio[955]: info: CoreStateMachine::startPlaybackTimer May 01 04:24:19 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:19 volumio volumio[955]: info: ControllerMpd::clearAddPlayTracks USB/F0DA-D872/MF Music The Complete Audiophile Collection (30CD 2014)/CD01 - A Lady Of Sadness (K2-022)/01. Meav - One I Love.flac May 01 04:24:19 volumio volumio[955]: info: ControllerMpd::sendMpdCommand stop May 01 04:24:19 volumio volumio[955]: info: sending command... May 01 04:24:19 volumio volumio[955]: info: parsing response... May 01 04:24:19 volumio volumio[955]: info: ControllerMpd::sendMpdCommand clear May 01 04:24:19 volumio volumio[955]: info: sending command... May 01 04:24:19 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: ---------------------------- MPD announces system playlist update May 01 04:24:19 volumio volumio[955]: info: Ignoring MPD Status Update May 01 04:24:19 volumio volumio[955]: info: parsing response... May 01 04:24:19 volumio volumio[955]: info: ControllerMpd::sendMpdCommand add "USB/F0DA-D872/MF Music The Complete Audiophile Collection (30CD 2014)/CD01 - A Lady Of Sadness (K2-022)/01. Meav - One I Love.flac" May 01 04:24:19 volumio volumio[955]: info: sending command... May 01 04:24:19 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: ---------------------------- MPD announces system playlist update May 01 04:24:19 volumio volumio[955]: info: Ignoring MPD Status Update May 01 04:24:19 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: ---------------------------- MPD announces system playlist update May 01 04:24:19 volumio volumio[955]: info: Ignoring MPD Status Update May 01 04:24:19 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: info: May 01 04:24:19 volumio volumio[955]: info: ------------------------------ 12ms May 01 04:24:19 volumio volumio[955]: info: ------------------------------ 8ms May 01 04:24:19 volumio volumio[955]: info: ------------------------------ 6ms May 01 04:24:27 volumio kernel: usb 1-1.2: device descriptor read/64, error -110 May 01 04:24:28 volumio kernel: usb 1-1.2: new high-speed USB device number 8 using dwc_otg May 01 04:24:33 volumio kernel: usb 1-1.2: device descriptor read/64, error -110 May 01 04:24:34 volumio kernel: usb 1-1.2: device descriptor read/64, error -71 May 01 04:24:34 volumio kernel: usb 1-1-port2: attempt power cycle May 01 04:24:35 volumio kernel: usb 1-1.2: new high-speed USB device number 9 using dwc_otg May 01 04:24:35 volumio kernel: usb 1-1.2: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.27 May 01 04:24:35 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 01 04:24:35 volumio kernel: usb 1-1.2: Product: Cruzer Blade May 01 04:24:35 volumio kernel: usb 1-1.2: Manufacturer: SanDisk May 01 04:24:35 volumio kernel: usb 1-1.2: SerialNumber: 20042204800320E2755A May 01 04:24:35 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected May 01 04:24:35 volumio kernel: scsi host0: usb-storage 1-1.2:1.0 May 01 04:24:36 volumio kernel: scsi 0:0:0:0: Direct-Access SanDisk Cruzer Blade 1.27 PQ: 0 ANSI: 6 May 01 04:24:36 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 May 01 04:24:36 volumio kernel: sd 0:0:0:0: [sda] 62530624 512-byte logical blocks: (32.0 GB/29.8 GiB) May 01 04:24:36 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off May 01 04:24:36 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 May 01 04:24:36 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA May 01 04:24:36 volumio kernel: sda: sda1 May 01 04:24:36 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk May 01 04:24:36 volumio udisks-glue[561]: Device file /dev/sda inserted May 01 04:24:36 volumio udisks-glue[561]: Device file /dev/sda1 inserted May 01 04:24:36 volumio udisks-glue[561]: Trying to automount /dev/sda1... May 01 04:24:36 volumio ntfs-3g[3748]: Version 2014.2.15AR.2 integrated FUSE 28 May 01 04:24:36 volumio ntfs-3g[3748]: Mounted /dev/sda1 (Read-Write, label "32GB", NTFS 3.1) May 01 04:24:36 volumio ntfs-3g[3748]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks May 01 04:24:36 volumio ntfs-3g[3748]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 May 01 04:24:36 volumio ntfs-3g[3748]: Global ownership and permissions enforced, configuration type 7 May 01 04:24:36 volumio udisks-glue[561]: Successfully automounted /dev/sda1 at /media/32GB May 01 04:24:36 volumio udisks-glue[561]: Device file /dev/sda1 mounted at /media/32GB May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:36 volumio udisks-glue[561]: Updating DB (#3) ... May 01 04:24:36 volumio udisks-glue[561]: volume:100% repeat: off random: off single: off consume: off May 01 04:24:36 volumio volumio[955]: info: May 01 04:24:36 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:24:36 volumio volumio[955]: info: sending command... May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::getState May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:36 volumio volumio[955]: info: sending command... May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:36 volumio volumio[955]: info: May 01 04:24:36 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:24:36 volumio volumio[955]: info: sending command... May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::getState May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:36 volumio volumio[955]: info: sending command... May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:36 volumio volumio[955]: info: May 01 04:24:36 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:24:36 volumio volumio[955]: info: sending command... May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::getState May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:24:36 volumio volumio[955]: info: sending command... May 01 04:24:36 volumio volumio[955]: info: parsing response... May 01 04:24:36 volumio volumio[955]: info: parsing response... May 01 04:24:36 volumio volumio[955]: info: parsing response... May 01 04:24:36 volumio volumio[955]: info: parsing response... May 01 04:24:36 volumio volumio[955]: info: parsing response... May 01 04:24:36 volumio volumio[955]: info: parsing response... May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:36 volumio volumio[955]: info: Command Router : Notfying DB Updatetrue May 01 04:24:36 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:36 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:36 volumio volumio[955]: info: Command Router : Notfying DB Updatetrue May 01 04:24:36 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:24:37 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:37 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:37 volumio volumio[955]: info: Command Router : Notfying DB Updatetrue May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:24:37 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:24:37 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:24:37 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio sudo[3759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3759]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio volumio[955]: info: No code May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3759]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio sudo[3763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:24:37 volumio kernel: usb 1-1.2: reset high-speed USB device number 9 using dwc_otg May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio sudo[3763]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio sudo[3763]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio sudo[3770]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:24:37 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio sudo[3770]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio volumio[955]: info: No code May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio sudo[3781]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio sudo[3787]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio sudo[3781]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio sudo[3787]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:24:37 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3796]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio sudo[3796]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio volumio[955]: info: No code May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:24:37 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:24:37 volumio sudo[3806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:24:37 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:24:37 volumio sudo[3806]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio sudo[3813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio sudo[3806]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio sudo[3813]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio sudo[3822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:24:37 volumio sudo[3813]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio volumio[955]: info: ------------------------------ 588ms May 01 04:24:37 volumio volumio[955]: info: ------------------------------ 585ms May 01 04:24:37 volumio sudo[3822]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:24:37 volumio volumio[955]: info: ------------------------------ 583ms May 01 04:24:37 volumio sudo[3822]: pam_unix(sudo:session): session closed for user root May 01 04:24:37 volumio kernel: usb 1-1.2: device descriptor read/64, error -71 May 01 04:24:38 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=0x00 May 01 04:24:38 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 03 7f d8 00 00 f0 00 May 01 04:24:38 volumio kernel: print_req_error: I/O error, dev sda, sector 229336 May 01 04:24:40 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 04:24:40 volumio volumio[955]: info: CURURI: music-library May 01 04:24:42 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 04:24:42 volumio volumio[955]: info: CURURI: music-library/USB May 01 04:24:43 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 04:24:43 volumio volumio[955]: info: CURURI: music-library/USB/32GB May 01 04:24:43 volumio kernel: dwc_otg: DEVICE:009 : update_urb_state_xfer_comp:751:trimming xfer length May 01 04:24:43 volumio kernel: usb 1-1.2: reset high-speed USB device number 9 using dwc_otg May 01 04:24:48 volumio kernel: usb 1-1.2: device descriptor read/64, error -110 May 01 04:25:04 volumio kernel: usb 1-1.2: device descriptor read/64, error -110 May 01 04:25:04 volumio kernel: usb 1-1.2: reset high-speed USB device number 9 using dwc_otg May 01 04:25:09 volumio kernel: usb 1-1.2: device descriptor read/64, error -110 May 01 04:25:24 volumio kernel: usb 1-1.2: device descriptor read/64, error -110 May 01 04:25:25 volumio kernel: usb 1-1.2: reset high-speed USB device number 9 using dwc_otg May 01 04:25:30 volumio kernel: usb 1-1.2: device descriptor read/8, error -110 May 01 04:25:35 volumio kernel: usb 1-1.2: device descriptor read/8, error -110 May 01 04:25:35 volumio kernel: usb 1-1.2: reset high-speed USB device number 9 using dwc_otg May 01 04:25:40 volumio kernel: usb 1-1.2: device descriptor read/8, error -110 May 01 04:25:45 volumio kernel: usb 1-1.2: device descriptor read/8, error -110 May 01 04:25:45 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x03 driverbyte=0x00 May 01 04:25:45 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 02 f4 4e b0 00 00 f0 00 May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565360 May 01 04:25:45 volumio kernel: usb 1-1.2: USB disconnect, device number 9 May 01 04:25:45 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=0x00 May 01 04:25:45 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 02 f4 4f a0 00 00 10 00 May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565600 May 01 04:25:45 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=0x00 May 01 04:25:45 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 02 f4 4f b0 00 00 f0 00 May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565616 May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565856 May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565360 May 01 04:25:45 volumio kernel: buffer_io_error: 13 callbacks suppressed May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565360 May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565360 May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565424 May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195422, async page read May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 114688: 131072 <> 98304: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 32768 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 245760: 131072 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 4096 <> -1: Input/output error May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565360 May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio kernel: print_req_error: I/O error, dev sda, sector 49565360 May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/08.Last Christmas.flac' at offset 212992: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/09.It's Not Goodbye.flac' at offset 0: 16384 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/09.It's Not Goodbye.flac' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/09.It's Not Goodbye.flac' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/09.It's Not Goodbye.flac' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/HI-FI天王天后 [FLAC]/cover.jpg' at offset 0: 112954 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/HI-FI天王天后 [FLAC]/cover.jpg' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/10.Hallelujah.flac' at offset 0: 16384 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/10.Hallelujah.flac' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/10.Hallelujah.flac' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread error reading '/Yao Si Ting - Collection - (10CDs) (2006 - 2011) {HQM}/Yao Si Ting - 7 Eternal Singing - Endless Love VII (2009) [FLAC]/10.Hallelujah.flac' at offset 0: 4096 <> -1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read of MFT, mft=1074 count=1 br=-1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read of MFT, mft=1075 count=1 br=-1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:45 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x0: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 01 04:25:46 volumio ntfs-3g[3748]: Failed to read vcn 0x1: Input/output error May 01 04:25:46 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:46 volumio kernel: Buffer I/O error on dev sda1, logical block 6195414, async page read May 01 04:25:45 volumio systemd-udevd[3852]: inotify_add_watch(6, /dev/sda, 10) failed: No such file or directory May 01 04:25:46 volumio udisks-glue[561]: Unable to get property "DeviceIsMediaAvailable": Method "Get" with signature "ss" on interface "org.freedesktop.DBus.Properties" doesn't exist May 01 04:25:46 volumio udisks-glue[561]: Device file /dev/sda1 unmounted from /media/32GB May 01 04:25:46 volumio udisks-glue[561]: Device file /dev/sda1 removed May 01 04:25:46 volumio udisks-glue[561]: Device file /dev/sda removed May 01 04:25:46 volumio volumio[955]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read May 01 04:25:46 volumio volumio[955]: at Object.fs.readSync (fs.js:675:18) May 01 04:25:46 volumio volumio[955]: at Object.readSync (/volumio/node_modules/graceful-fs/polyfills.js:137:28) May 01 04:25:46 volumio volumio[955]: at copyFileSync (/volumio/node_modules/fs-extra/lib/copy-sync/copy-file-sync.js:28:20) May 01 04:25:46 volumio volumio[955]: at Object.copySync (/volumio/node_modules/fs-extra/lib/copy-sync/copy-sync.js:43:5) May 01 04:25:46 volumio volumio[955]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:251:28) May 01 04:25:46 volumio volumio[955]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:407:21) May 01 04:25:46 volumio volumio[955]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:468:19) May 01 04:25:46 volumio volumio[955]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 01 04:25:46 volumio volumio[955]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) May 01 04:25:46 volumio volumio[955]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) May 01 04:25:46 volumio volumio[955]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 01 04:25:46 volumio volumio[955]: at /volumio/node_modules/express/lib/router/index.js:281:22 May 01 04:25:46 volumio volumio[955]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) May 01 04:25:46 volumio volumio[955]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) May 01 04:25:46 volumio volumio[955]: at allowCrossDomain (/volumio/http/index.js:32:9) May 01 04:25:46 volumio volumio[955]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) May 01 04:25:46 volumio volumio[955]: Upnp client error: Error: This socket has been ended by the other party May 01 04:25:46 volumio udisks-glue[561]: Updating DB (#3) ... May 01 04:25:46 volumio udisks-glue[561]: volume:100% repeat: off random: off single: off consume: off May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 04:25:46 volumio udisks-glue[561]: Updating DB (#3) ... May 01 04:25:46 volumio udisks-glue[561]: volume:100% repeat: off random: off single: off consume: off May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::ClearQueue May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:25:46 volumio volumio[955]: UNSET VOLATILE May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::clearPlayQueue May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::saveQueue May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushEmptyState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushQueue May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::addQueueItems May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::addQueueItems May 01 04:25:46 volumio volumio[955]: info: Adding Item to queue: music-library/USB/32GB/HI-FI天王天后 [FLAC] May 01 04:25:46 volumio volumio[955]: info: Exploding uri music-library/USB/32GB/HI-FI天王天后 [FLAC] in service mpd May 01 04:25:46 volumio sudo[3866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: scanFolder - failure to stat '/mnt/USB/32GB/HI-FI天王天后 [FLAC]' May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::saveQueue May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushQueue May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::updateTrackBlock May 01 04:25:46 volumio sudo[3866]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrackBlock May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPlay May 01 04:25:46 volumio volumio[955]: UNSET VOLATILE May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::play index 0 May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:25:46 volumio volumio[955]: UNSET VOLATILE May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::play index undefined May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio sudo[3866]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio volumio[955]: info: MPD Database updated - AlbumList cache refreshed May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: database May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: MPD Database updated - AlbumList cache refreshed May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: database May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: MPD Database updated - AlbumList cache refreshed May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: database May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: May 01 04:25:46 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: parsing response... May 01 04:25:46 volumio volumio[955]: info: sending command... May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:46 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: No code May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3881]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio sudo[3881]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio sudo[3885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio sudo[3885]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:46 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:46 volumio sudo[3885]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3891]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio sudo[3899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: No code May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio sudo[3891]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio sudo[3899]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3899]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio sudo[3908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3908]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio sudo[3918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:46 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio sudo[3908]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio sudo[3918]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio sudo[3918]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio sudo[3924]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: No code May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3924]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio sudo[3936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio sudo[3936]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3936]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio sudo[3946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:46 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio kernel: usb 1-1.2: new high-speed USB device number 10 using dwc_otg May 01 04:25:46 volumio sudo[3946]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio sudo[3953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3946]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio sudo[3953]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio volumio[955]: info: No code May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio sudo[3953]: pam_unix(sudo:session): session closed for user root May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:46 volumio sudo[3968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:46 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:46 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:46 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:46 volumio sudo[3968]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:46 volumio sudo[3973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:46 volumio sudo[3968]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio sudo[3973]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio kernel: usb 1-1.2: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.27 May 01 04:25:47 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 May 01 04:25:47 volumio kernel: usb 1-1.2: Product: Cruzer Blade May 01 04:25:47 volumio kernel: usb 1-1.2: Manufacturer: SanDisk May 01 04:25:47 volumio kernel: usb 1-1.2: SerialNumber: 20042204800320E2755A May 01 04:25:47 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected May 01 04:25:47 volumio sudo[3973]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:47 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:47 volumio kernel: scsi host1: usb-storage 1-1.2:1.0 May 01 04:25:47 volumio sudo[3985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:47 volumio sudo[3985]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio volumio[955]: info: No code May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:47 volumio sudo[3985]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:47 volumio sudo[3997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:47 volumio sudo[3997]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:47 volumio sudo[3997]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio sudo[4005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:47 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio sudo[4005]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:47 volumio sudo[4005]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio sudo[4013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:47 volumio sudo[4013]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio sudo[4013]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio volumio[955]: info: No code May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:47 volumio sudo[4027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:47 volumio sudo[4027]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio sudo[4027]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio sudo[4033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:47 volumio sudo[4033]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:47 volumio sudo[4033]: pam_unix(sudo:session): session closed for user root May 01 04:25:47 volumio volumio[955]: info: ------------------------------ 1138ms May 01 04:25:47 volumio volumio[955]: info: ------------------------------ 1139ms May 01 04:25:47 volumio volumio[955]: info: ------------------------------ 1133ms May 01 04:25:47 volumio volumio[955]: info: ------------------------------ 1135ms May 01 04:25:47 volumio volumio[955]: info: ------------------------------ 1130ms May 01 04:25:47 volumio volumio[955]: info: ------------------------------ 1133ms May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:47 volumio volumio[955]: info: May 01 04:25:47 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:25:47 volumio volumio[955]: info: sending command... May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:47 volumio volumio[955]: info: sending command... May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:47 volumio volumio[955]: info: May 01 04:25:47 volumio volumio[955]: ---------------------------- MPD announces state update: update May 01 04:25:47 volumio volumio[955]: info: sending command... May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::getState May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::sendMpdCommand status May 01 04:25:47 volumio volumio[955]: info: sending command... May 01 04:25:47 volumio volumio[955]: info: CoreCommandRouter::volumioPlay May 01 04:25:47 volumio volumio[955]: UNSET VOLATILE May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::play index undefined May 01 04:25:47 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:25:47 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:47 volumio volumio[955]: info: parsing response... May 01 04:25:47 volumio volumio[955]: info: parsing response... May 01 04:25:47 volumio volumio[955]: info: parsing response... May 01 04:25:47 volumio volumio[955]: info: parsing response... May 01 04:25:47 volumio volumio[955]: info: parsing response... May 01 04:25:47 volumio volumio[955]: info: parsing response... May 01 04:25:47 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:48 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:48 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:48 volumio volumio[955]: info: Command Router : Notfying DB Updatefalse May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::Close All Modals sent May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::parseState May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:48 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio volumio[955]: info: No code May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio sudo[4052]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio sudo[4052]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:48 volumio sudo[4056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio sudo[4056]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio sudo[4063]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio sudo[4056]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio sudo[4063]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:48 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio sudo[4075]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio volumio[955]: info: No code May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio sudo[4075]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio sudo[4085]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio volumio[955]: info: ControllerMpd::pushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::servicePushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4085]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio sudo[4092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio sudo[4092]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 01 04:25:48 volumio volumio[955]: info: CURRENT POSITION 0 May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState stateService stop May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::syncState currentStatus stop May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio sudo[4092]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio sudo[4102]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio volumio[955]: info: No code May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::pushState May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::getState May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPushState May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 04:25:48 volumio sudo[4102]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio sudo[4111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio sudo[4111]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio volumio[955]: info: ------------------------------ 2236ms May 01 04:25:48 volumio volumio[955]: info: ------------------------------ 1140ms May 01 04:25:48 volumio sudo[4119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 04:25:48 volumio volumio[955]: info: ------------------------------ 1137ms May 01 04:25:48 volumio sudo[4111]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio sudo[4119]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 04:25:48 volumio sudo[4119]: pam_unix(sudo:session): session closed for user root May 01 04:25:48 volumio kernel: usb 1-1.2: reset high-speed USB device number 10 using dwc_otg May 01 04:25:48 volumio volumio[955]: info: No input data May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioPlay May 01 04:25:48 volumio volumio[955]: UNSET VOLATILE May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::play index undefined May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::getTrack 0 May 01 04:25:48 volumio volumio[955]: info: CoreCommandRouter::volumioMoveQueue May 01 04:25:48 volumio volumio[955]: info: CoreStateMachine::moveQueueItem 4 3 May 01 04:25:48 volumio volumio[955]: info: CorePlayQueue::moveQueueItem 4 --> 3 May 01 04:25:48 volumio volumio[955]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 04:25:48 volumio volumio[955]: ReferenceError: defer is not defined May 01 04:25:48 volumio volumio[955]: at CorePlayQueue.moveQueueItem (/volumio/app/playqueue.js:247:10) May 01 04:25:48 volumio volumio[955]: at CoreStateMachine.moveQueueItem (/volumio/app/statemachine.js:1608:20) May 01 04:25:48 volumio volumio[955]: at CoreCommandRouter.volumioMoveQueue (/volumio/app/index.js:1628:34) May 01 04:25:48 volumio volumio[955]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1407:55) May 01 04:25:48 volumio volumio[955]: at emitTwo (events.js:126:13) May 01 04:25:48 volumio volumio[955]: at Socket.emit (events.js:214:7) May 01 04:25:48 volumio volumio[955]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 01 04:25:48 volumio volumio[955]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 01 04:25:48 volumio volumio[955]: at process._tickCallback (internal/process/next_tick.js:180:9) May 01 04:25:48 volumio volumio[955]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 04:25:50 volumio sudo[4142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 04:24 May 01 04:25:50 volumio sudo[4142]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="e32e25d68d93383fe73e2a451c032b2661c71694" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jan 20 19:41:22 CET 2020" VOLUMIO_VERSION="2.699" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5faefe8928fcf34b6263aec4aa82825a"