-- Logs begin at Fri 2020-08-14 07:04:22 UTC, end at Tue 2024-04-30 12:11:46 UTC. -- Apr 30 12:10:01 volumio kernel: usb 1-1.4: USB disconnect, device number 8 Apr 30 12:10:01 volumio volumio[1499]: info: Apr 30 12:10:01 volumio volumio[1499]: ---------------------------- USB Audio Device Detached Apr 30 12:10:01 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 30 12:10:02 volumio kernel: usb 1-1.4: new high-speed USB device number 9 using xhci_hcd Apr 30 12:10:02 volumio kernel: usb 1-1.4: New USB device found, idVendor=16d0, idProduct=071a, bcdDevice= 1.97 Apr 30 12:10:02 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 30 12:10:02 volumio kernel: usb 1-1.4: Product: Combo384 Amanero Apr 30 12:10:02 volumio kernel: usb 1-1.4: Manufacturer: Amanero Technologies Apr 30 12:10:02 volumio kernel: usb 1-1.4: SerialNumber: 413-001 Apr 30 12:10:02 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:10:02 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Apr 30 12:10:02 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:10:02 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Apr 30 12:10:02 volumio volumio[1499]: info: Apr 30 12:10:02 volumio volumio[1499]: ---------------------------- USB Audio Device Attached Apr 30 12:10:02 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::volumioGetBrowseSources Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:03 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 30 12:10:07 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:11 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:14 volumio volumio[1499]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Apr 30 12:10:14 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Apr 30 12:10:15 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Apr 30 12:10:15 volumio volumio[1499]: info: Rebuild Album cache Apr 30 12:10:15 volumio volumio[1499]: Cannot compose Albumart path Apr 30 12:10:15 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:15 volumio kernel: usb 1-1.4: USB disconnect, device number 9 Apr 30 12:10:15 volumio volumio[1499]: info: Apr 30 12:10:15 volumio volumio[1499]: ---------------------------- USB Audio Device Detached Apr 30 12:10:15 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 30 12:10:15 volumio kernel: usb 1-1.4: new high-speed USB device number 10 using xhci_hcd Apr 30 12:10:16 volumio kernel: usb 1-1.4: New USB device found, idVendor=16d0, idProduct=071a, bcdDevice= 1.97 Apr 30 12:10:16 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 30 12:10:16 volumio kernel: usb 1-1.4: Product: Combo384 Amanero Apr 30 12:10:16 volumio kernel: usb 1-1.4: Manufacturer: Amanero Technologies Apr 30 12:10:16 volumio kernel: usb 1-1.4: SerialNumber: 413-001 Apr 30 12:10:16 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:10:16 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Apr 30 12:10:16 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:10:16 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Apr 30 12:10:16 volumio volumio[1499]: info: Apr 30 12:10:16 volumio volumio[1499]: ---------------------------- USB Audio Device Attached Apr 30 12:10:16 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 30 12:10:19 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:23 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:27 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:31 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:35 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:36 volumio volumio[1499]: info: CALLMETHOD: miscellanea my_music updateMusicLibraryBrowseSourcesVisibility [object Object] Apr 30 12:10:36 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibraryBrowseSourcesVisibility Apr 30 12:10:36 volumio volumio[1499]: info: CoreCommandRouter::volumioUpdateToBrowseSources Apr 30 12:10:36 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 30 12:10:39 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:43 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:47 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 12:10:55 volumio sudo[2312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 30 12:10:55 volumio sudo[2312]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:10:55 volumio sudo[2312]: pam_unix(sudo:session): session closed for user root Apr 30 12:10:55 volumio sudo[2314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:10:55 volumio sudo[2314]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:10:55 volumio sudo[2314]: pam_unix(sudo:session): session closed for user root Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::volumioGetVisibleSources Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::volumioGetState Apr 30 12:10:55 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:10:55 volumio volumio[1499]: info: CorePlayQueue::getTrack 0 Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::volumioGetQueue Apr 30 12:10:55 volumio volumio[1499]: info: CoreStateMachine::getQueue Apr 30 12:10:55 volumio volumio[1499]: info: CorePlayQueue::getQueue Apr 30 12:10:55 volumio volumio[1499]: info: Listing playlists Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 30 12:10:55 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 30 12:10:55 volumio sudo[2332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:10:55 volumio sudo[2332]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:10:55 volumio sudo[2332]: pam_unix(sudo:session): session closed for user root Apr 30 12:10:57 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 30 12:10:58 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 12:10:58 volumio volumio[1499]: info: CURURI: music-library Apr 30 12:10:59 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 12:10:59 volumio volumio[1499]: info: CURURI: music-library/USB Apr 30 12:11:00 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 12:11:00 volumio volumio[1499]: info: CURURI: music-library/USB/HDD_1T Apr 30 12:11:00 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 30 12:11:00 volumio volumio[1499]: info: CURURI: music-library/USB/HDD_1T/12345 Apr 30 12:11:10 volumio volumio[1499]: info: CoreCommandRouter::volumioAddQueueItems Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::addQueueItems Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::addQueueItems Apr 30 12:11:10 volumio volumio[1499]: info: Adding Item to queue: music-library/USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac Apr 30 12:11:10 volumio volumio[1499]: info: Exploding uri music-library/USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac in service mpd Apr 30 12:11:10 volumio volumio[1499]: info: ALBUMART /albumart?cacheid=370&web=%E5%BC%A0%E9%9F%B6%E6%B6%B5/Over%20The%20Rainbow/extralarge&path=%2Fmnt%2FUSB%2FHDD_1T%2F12345%2F%E5%BC%A0%E9%9F%B6%E6%B6%B5%20-%20%E9%81%97%E5%A4%B1%E7%9A%84%E7%BE%8E%E5%A5%BD.flac&metadata=false Apr 30 12:11:10 volumio volumio[1499]: info: URI /mnt/USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::saveQueue Apr 30 12:11:10 volumio volumio[1499]: info: CoreCommandRouter::volumioPushQueue Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::updateTrackBlock Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::getTrackBlock Apr 30 12:11:10 volumio volumio[1499]: info: CoreCommandRouter::volumioPlay Apr 30 12:11:10 volumio volumio[1499]: UNSET VOLATILE Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::play index 1 Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::stop Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:11:10 volumio volumio[1499]: UNSET VOLATILE Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::stPlaybackTimer Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::updateTrackBlock Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::getTrackBlock Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::getTrack 0 Apr 30 12:11:10 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:10 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::serviceStop Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::getTrack 0 Apr 30 12:11:10 volumio volumio[1499]: info: CoreCommandRouter::serviceStop Apr 30 12:11:10 volumio volumio[1499]: info: ControllerMpd::stop Apr 30 12:11:10 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand stop Apr 30 12:11:10 volumio sudo[2341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:10 volumio volumio[1499]: info: sending command... Apr 30 12:11:10 volumio sudo[2341]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:10 volumio sudo[2341]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:10 volumio volumio[1499]: info: parsing response... Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::play index undefined Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:10 volumio volumio[1499]: info: CoreStateMachine::startPlaybackTimer Apr 30 12:11:10 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:10 volumio volumio[1499]: info: ControllerMpd::clearAddPlayTracks USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac Apr 30 12:11:10 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand stop Apr 30 12:11:10 volumio volumio[1499]: info: sending command... Apr 30 12:11:10 volumio volumio[1499]: info: Apr 30 12:11:10 volumio volumio[1499]: ---------------------------- MPD announces state update: player Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::getState Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand status Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand clear Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: Apr 30 12:11:11 volumio volumio[1499]: ---------------------------- MPD announces system playlist update Apr 30 12:11:11 volumio volumio[1499]: info: Ignoring MPD Status Update Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::parseState Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand add "USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac" Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: Apr 30 12:11:11 volumio volumio[1499]: info: Apr 30 12:11:11 volumio volumio[1499]: ---------------------------- MPD announces system playlist update Apr 30 12:11:11 volumio volumio[1499]: info: Ignoring MPD Status Update Apr 30 12:11:11 volumio volumio[1499]: info: ------------------------------ 4ms Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::parseTrackInfo Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand play Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::pushError Apr 30 12:11:11 volumio volumio[1499]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined Apr 30 12:11:11 volumio volumio[1499]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) Apr 30 12:11:11 volumio volumio[1499]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 12:11:11 volumio volumio[1499]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Apr 30 12:11:11 volumio volumio[1499]: at process._tickCallback (internal/process/next_tick.js:180:9) Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: ------------------------------ 13ms Apr 30 12:11:11 volumio volumio[1499]: info: ------------------------------ 8ms Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: Apr 30 12:11:11 volumio volumio[1499]: ---------------------------- MPD announces state update: player Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::getState Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand status Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: Apr 30 12:11:11 volumio volumio[1499]: ---------------------------- MPD announces state update: player Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::getState Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand status Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::parseState Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::parseState Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::parseTrackInfo Apr 30 12:11:11 volumio volumio[1499]: info: sending command... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::pushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::servicePushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::syncState Apr 30 12:11:11 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:11 volumio volumio[1499]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"遗失的美好","artist":"张韶涵","album":"Over The Rainbow","uri":"USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac","trackType":"flac"} Apr 30 12:11:11 volumio volumio[1499]: info: CURRENT POSITION 1 Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::syncState stateService play Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::syncState currentStatus stop Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:11 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:11 volumio volumio[1499]: info: ------------------------------ 28ms Apr 30 12:11:11 volumio sudo[2350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:11 volumio sudo[2350]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:11 volumio volumio[1499]: info: parsing response... Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::parseTrackInfo Apr 30 12:11:11 volumio volumio[1499]: info: ControllerMpd::pushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::servicePushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::syncState Apr 30 12:11:11 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:11 volumio volumio[1499]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"遗失的美好","artist":"张韶涵","album":"Over The Rainbow","uri":"USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac","trackType":"flac"} Apr 30 12:11:11 volumio volumio[1499]: info: CURRENT POSITION 1 Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::syncState stateService play Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::syncState currentStatus play Apr 30 12:11:11 volumio volumio[1499]: info: Received an update from plugin. extracting info from payload Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:11 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:11 volumio sudo[2350]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:11 volumio sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:11 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:11 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:11 volumio sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:11 volumio sudo[2356]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:11 volumio volumio[1499]: info: ------------------------------ 68ms Apr 30 12:11:11 volumio sudo[2362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:11 volumio sudo[2362]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:11 volumio sudo[2362]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:12 volumio volumio[1499]: info: CoreCommandRouter::volumioGetState Apr 30 12:11:12 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:12 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:14 volumio kernel: usb 1-1.4: USB disconnect, device number 10 Apr 30 12:11:14 volumio volumio[1499]: info: Apr 30 12:11:14 volumio volumio[1499]: ---------------------------- USB Audio Device Detached Apr 30 12:11:14 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 30 12:11:15 volumio kernel: usb 1-1.4: new high-speed USB device number 11 using xhci_hcd Apr 30 12:11:15 volumio kernel: usb 1-1.4: New USB device found, idVendor=16d0, idProduct=071a, bcdDevice= 1.97 Apr 30 12:11:15 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 30 12:11:15 volumio kernel: usb 1-1.4: Product: Combo384 Amanero Apr 30 12:11:15 volumio kernel: usb 1-1.4: Manufacturer: Amanero Technologies Apr 30 12:11:15 volumio kernel: usb 1-1.4: SerialNumber: 413-001 Apr 30 12:11:15 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:11:15 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Apr 30 12:11:15 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:11:15 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Apr 30 12:11:15 volumio volumio[1499]: info: Apr 30 12:11:15 volumio volumio[1499]: ---------------------------- USB Audio Device Attached Apr 30 12:11:15 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 30 12:11:22 volumio kernel: usb 1-1.4: USB disconnect, device number 11 Apr 30 12:11:22 volumio volumio[1499]: info: Apr 30 12:11:22 volumio volumio[1499]: ---------------------------- USB Audio Device Detached Apr 30 12:11:22 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Apr 30 12:11:23 volumio kernel: usb 1-1.4: new high-speed USB device number 12 using xhci_hcd Apr 30 12:11:23 volumio kernel: usb 1-1.4: New USB device found, idVendor=16d0, idProduct=071a, bcdDevice= 1.97 Apr 30 12:11:23 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 30 12:11:23 volumio kernel: usb 1-1.4: Product: Combo384 Amanero Apr 30 12:11:23 volumio kernel: usb 1-1.4: Manufacturer: Amanero Technologies Apr 30 12:11:23 volumio kernel: usb 1-1.4: SerialNumber: 413-001 Apr 30 12:11:23 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:11:23 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Apr 30 12:11:23 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 30 12:11:23 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Apr 30 12:11:23 volumio volumio[1499]: info: Apr 30 12:11:23 volumio volumio[1499]: ---------------------------- USB Audio Device Attached Apr 30 12:11:23 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 30 12:11:29 volumio startx[739]: {} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0', 'updating_db': '1'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Apr 30 12:11:29 volumio startx[739]: {} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0', 'updating_db': '1'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Apr 30 12:11:29 volumio startx[739]: {} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0', 'updating_db': '1'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: All pass! the cover updated Apr 30 12:11:29 volumio startx[739]: {} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: All pass! the cover updated Apr 30 12:11:29 volumio startx[739]: {} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: All pass! the cover updated{} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: All pass! the cover updated Apr 30 12:11:29 volumio startx[739]: {} Apr 30 12:11:29 volumio startx[739]: {'playlistlength': '0', 'playlist': '1', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'stop', 'volume': '100', 'single': '0'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: All pass! the cover updated Apr 30 12:11:29 volumio startx[739]: {'album': '2 Love \xe8\x87\xb4\xe6\x83\x85\xe6\x8c\x9a\xe7\x88\xb1', 'title': '\xe5\xb9\xbf\xe5\xb2\x9b\xe4\xb9\x8b\xe6\x81\x8b', 'track': '4', 'duration': '321.253', 'artist': '\xe5\xbc\xa0\xe6\xb4\xaa\xe9\x87\x8f', 'pos': '0', 'last-modified': '2019-02-19T17:47:09Z', 'disc': '0', 'file': 'USB/HDD_1T/12345/\xe5\xbc\xa0\xe6\xb4\xaa\xe9\x87\x8f _ \xe8\x8e\xab\xe6\x96\x87\xe8\x94\x9a - \xe5\xb9\xbf\xe5\xb2\x9b\xe4\xb9\x8b\xe6\x81\x8b.mp3', 'time': '321', 'genre': 'Blues', 'id': '1'} Apr 30 12:11:29 volumio startx[739]: {'songid': '1', 'playlistlength': '1', 'playlist': '3', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '1.184', 'volume': '100', 'single': '0', 'time': '1:321', 'duration': '321.253', 'song': '0', 'audio': '44100:24:2', 'bitrate': '320'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: All pass! the cover updated Apr 30 12:11:29 volumio startx[739]: {'album': 'Over The Rainbow', 'artist': '\xe5\xbc\xa0\xe9\x9f\xb6\xe6\xb6\xb5', 'track': '11', 'title': '\xe9\x81\x97\xe5\xa4\xb1\xe7\x9a\x84\xe7\xbe\x8e\xe5\xa5\xbd', 'pos': '0', 'last-modified': '2019-08-10T16:04:41Z', 'disc': '1', 'file': 'USB/HDD_1T/12345/\xe5\xbc\xa0\xe9\x9f\xb6\xe6\xb6\xb5 - \xe9\x81\x97\xe5\xa4\xb1\xe7\x9a\x84\xe7\xbe\x8e\xe5\xa5\xbd.flac', 'time': '261', 'duration': '261.253', 'id': '2'} Apr 30 12:11:29 volumio startx[739]: {'songid': '2', 'playlistlength': '1', 'playlist': '5', 'repeat': '0', 'consume': '0', 'mixrampdb': '0.000000', 'random': '0', 'state': 'play', 'elapsed': '1.160', 'volume': '100', 'single': '0', 'time': '1:261', 'duration': '261.253', 'song': '0', 'audio': '44100:16:2', 'bitrate': '433'} Apr 30 12:11:29 volumio startx[739]: Create Threading to get Cover!! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:29 volumio startx[739]: Getting.....so abort! Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioAddQueueItems Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::addQueueItems Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::addQueueItems Apr 30 12:11:32 volumio volumio[1499]: info: Adding Item to queue: music-library/USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac Apr 30 12:11:32 volumio volumio[1499]: info: Exploding uri music-library/USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac in service mpd Apr 30 12:11:32 volumio volumio[1499]: info: ALBUMART /albumart?cacheid=370&web=%E5%AD%9F%E5%BA%AD%E8%8B%87/%E5%86%AC%E5%AD%A3%E5%88%B0%E5%8F%B0%E5%8C%97%E6%9D%A5%E7%9C%8B%E9%9B%A8/extralarge&path=%2Fmnt%2FUSB%2FHDD_1T%2F12345%2F%E5%AD%9F%E5%BA%AD%E8%8B%87%20-%20%E5%86%AC%E5%AD%A3%E5%88%B0%E5%8F%B0%E5%8C%97%E6%9D%A5%E7%9C%8B%E9%9B%A8.flac&metadata=false Apr 30 12:11:32 volumio volumio[1499]: info: URI /mnt/USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::saveQueue Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushQueue Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::updateTrackBlock Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrackBlock Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPlay Apr 30 12:11:32 volumio volumio[1499]: UNSET VOLATILE Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::play index 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::stop Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:11:32 volumio volumio[1499]: UNSET VOLATILE Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::stPlaybackTimer Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::updateTrackBlock Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrackBlock Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::serviceStop Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 1 Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::serviceStop Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::stop Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand stop Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio sudo[2400]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio sudo[2400]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:32 volumio volumio[1499]: info: Apr 30 12:11:32 volumio volumio[1499]: ---------------------------- MPD announces state update: player Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::getState Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand status Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::play index undefined Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::startPlaybackTimer Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::clearAddPlayTracks USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand stop Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::parseState Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand clear Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: Apr 30 12:11:32 volumio volumio[1499]: ---------------------------- MPD announces system playlist update Apr 30 12:11:32 volumio volumio[1499]: info: Ignoring MPD Status Update Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::parseTrackInfo Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand add "USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac" Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::servicePushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"遗失的美好","artist":"张韶涵","album":"Over The Rainbow","uri":"USB/HDD_1T/12345/张韶涵 - 遗失的美好.flac","trackType":"flac"} Apr 30 12:11:32 volumio volumio[1499]: info: CURRENT POSITION 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState stateService stop Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState currentStatus stop Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio sudo[2409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio sudo[2409]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio volumio[1499]: info: No code Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio sudo[2409]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio sudo[2416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio volumio[1499]: info: ------------------------------ 76ms Apr 30 12:11:32 volumio volumio[1499]: info: Apr 30 12:11:32 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:32 volumio volumio[1499]: info: Apr 30 12:11:32 volumio volumio[1499]: ---------------------------- MPD announces system playlist update Apr 30 12:11:32 volumio volumio[1499]: info: Ignoring MPD Status Update Apr 30 12:11:32 volumio volumio[1499]: info: ------------------------------ 71ms Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand play Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio sudo[2420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio volumio[1499]: info: Apr 30 12:11:32 volumio volumio[1499]: ---------------------------- MPD announces state update: player Apr 30 12:11:32 volumio volumio[1499]: info: ------------------------------ 16ms Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::getState Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand status Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: Apr 30 12:11:32 volumio volumio[1499]: ---------------------------- MPD announces state update: player Apr 30 12:11:32 volumio sudo[2420]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::getState Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand status Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::parseState Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::parseState Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: sending command... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: parsing response... Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::parseTrackInfo Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::parseTrackInfo Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::servicePushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio sudo[2420]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:32 volumio volumio[1499]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":309,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"冬季到台北来看雨","artist":"孟庭苇","album":"冬季到台北来看雨","uri":"USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac","trackType":"flac"} Apr 30 12:11:32 volumio volumio[1499]: info: CURRENT POSITION 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState stateService play Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState currentStatus stop Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio volumio[1499]: info: ControllerMpd::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::servicePushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":309,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"冬季到台北来看雨","artist":"孟庭苇","album":"冬季到台北来看雨","uri":"USB/HDD_1T/12345/孟庭苇 - 冬季到台北来看雨.flac","trackType":"flac"} Apr 30 12:11:32 volumio volumio[1499]: info: CURRENT POSITION 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState stateService play Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::syncState currentStatus play Apr 30 12:11:32 volumio volumio[1499]: info: Received an update from plugin. extracting info from payload Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio sudo[2436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio sudo[2436]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::pushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreStateMachine::getState Apr 30 12:11:32 volumio volumio[1499]: info: CorePlayQueue::getTrack 2 Apr 30 12:11:32 volumio sudo[2436]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::volumioPushState Apr 30 12:11:32 volumio volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 12:11:32 volumio sudo[2441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio volumio[1499]: info: ------------------------------ 70ms Apr 30 12:11:32 volumio volumio[1499]: info: ------------------------------ 67ms Apr 30 12:11:32 volumio sudo[2447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 30 12:11:32 volumio sudo[2441]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio sudo[2447]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 12:11:32 volumio sudo[2447]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:32 volumio sudo[2441]: pam_unix(sudo:session): session closed for user root Apr 30 12:11:45 volumio volumio[1499]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 12:11:45 volumio volumio[1499]: { Error: connect ETIMEDOUT 31.13.87.34:443 Apr 30 12:11:45 volumio volumio[1499]: at Object._errnoException (util.js:1022:11) Apr 30 12:11:45 volumio volumio[1499]: at _exceptionWithHostPort (util.js:1044:20) Apr 30 12:11:45 volumio volumio[1499]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 30 12:11:45 volumio volumio[1499]: code: 'ETIMEDOUT', Apr 30 12:11:45 volumio volumio[1499]: errno: 'ETIMEDOUT', Apr 30 12:11:45 volumio volumio[1499]: syscall: 'connect', Apr 30 12:11:45 volumio volumio[1499]: address: '31.13.87.34', Apr 30 12:11:45 volumio volumio[1499]: port: 443 } Apr 30 12:11:45 volumio volumio[1499]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 12:11:46 volumio sudo[2471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-30 12:10 Apr 30 12:11:46 volumio sudo[2471]: 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"