-- Logs begin at Sat 2024-07-20 12:27:58 CST, end at Sat 2024-07-20 15:25:35 CST. -- Jul 20 15:24:06 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:24:07 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:24:07 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:24:13 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:24:13 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:24:17 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:24:23 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:24:28 volumio volumio[485]: info: CorePlayQueue::getTrack 5 Jul 20 15:24:28 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:28 volumio volumio[485]: info: Prefetching next song Jul 20 15:24:28 volumio volumio[485]: info: DOING PREFETCH IN MPD Jul 20 15:24:28 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand add "NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac" Jul 20 15:24:28 volumio volumio[485]: info: sendMpdCommand add "NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac" took 1 milliseconds Jul 20 15:24:28 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 20 15:24:28 volumio volumio[485]: info: Jul 20 15:24:28 volumio volumio[485]: ---------------------------- MPD announces system playlist update Jul 20 15:24:28 volumio volumio[485]: info: Ignoring MPD Status Update Jul 20 15:24:28 volumio volumio[485]: info: sendMpdCommand consume 1 took 1 milliseconds Jul 20 15:24:28 volumio volumio[485]: info: Jul 20 15:24:28 volumio volumio[485]: ---------------------------- MPD announces system playlist update Jul 20 15:24:28 volumio volumio[485]: info: Ignoring MPD Status Update Jul 20 15:24:28 volumio volumio[485]: info: Jul 20 15:24:28 volumio volumio[485]: ---------------------------- MPD announces system playlist update Jul 20 15:24:28 volumio volumio[485]: info: Ignoring MPD Status Update Jul 20 15:24:28 volumio volumio[485]: info: ------------------------------ 5ms Jul 20 15:24:28 volumio volumio[485]: info: ------------------------------ 3ms Jul 20 15:24:28 volumio volumio[485]: info: ------------------------------ 3ms Jul 20 15:24:33 volumio volumio[485]: info: CoreStateMachine::startPlaybackTimer Jul 20 15:24:33 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:33 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:33 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:33 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 15:24:33 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: Jul 20 15:24:34 volumio volumio[485]: ---------------------------- MPD announces system playlist update Jul 20 15:24:34 volumio volumio[485]: info: Ignoring MPD Status Update Jul 20 15:24:34 volumio volumio[485]: info: Jul 20 15:24:34 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:24:34 volumio volumio[485]: info: ControllerMpd::getState Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand status Jul 20 15:24:34 volumio volumio[485]: info: Jul 20 15:24:34 volumio volumio[485]: ---------------------------- MPD announces system playlist update Jul 20 15:24:34 volumio volumio[485]: info: Ignoring MPD Status Update Jul 20 15:24:34 volumio volumio[485]: info: Jul 20 15:24:34 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:24:34 volumio volumio[485]: info: ControllerMpd::getState Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand status Jul 20 15:24:34 volumio volumio[485]: info: Jul 20 15:24:34 volumio volumio[485]: ---------------------------- MPD announces system playlist update Jul 20 15:24:34 volumio volumio[485]: info: Ignoring MPD Status Update Jul 20 15:24:34 volumio volumio[485]: info: Jul 20 15:24:34 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:24:34 volumio volumio[485]: info: ControllerMpd::getState Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand status Jul 20 15:24:34 volumio volumio[485]: info: ------------------------------ 8ms Jul 20 15:24:34 volumio volumio[485]: info: sendMpdCommand status took 8 milliseconds Jul 20 15:24:34 volumio volumio[485]: info: ------------------------------ 7ms Jul 20 15:24:34 volumio volumio[485]: info: sendMpdCommand status took 6 milliseconds Jul 20 15:24:34 volumio volumio[485]: info: ------------------------------ 5ms Jul 20 15:24:34 volumio volumio[485]: info: sendMpdCommand status took 3 milliseconds Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::parseState Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::parseState Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::parseState Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 15:24:34 volumio volumio[485]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 20 15:24:34 volumio volumio[485]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 20 15:24:34 volumio volumio[485]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::parseTrackInfo Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::parseTrackInfo Jul 20 15:24:34 volumio volumio[485]: verbose: ControllerMpd::parseTrackInfo Jul 20 15:24:34 volumio volumio[485]: info: ControllerMpd::pushState Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::servicePushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1019 Kbps","isStreaming":false,"title":"It's a Sin ","artist":"Pet Shop Boys","album":"Discography The Complete Singles Collection","uri":"NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac","trackType":"flac"} Jul 20 15:24:34 volumio volumio[485]: verbose: CURRENT POSITION 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::syncState stateService play Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::syncState currentStatus play Jul 20 15:24:34 volumio volumio[485]: info: Received an update from plugin. extracting info from payload Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: ControllerMpd::pushState Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::servicePushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1019 Kbps","isStreaming":false,"title":"It's a Sin ","artist":"Pet Shop Boys","album":"Discography The Complete Singles Collection","uri":"NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac","trackType":"flac"} Jul 20 15:24:34 volumio volumio[485]: verbose: CURRENT POSITION 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::syncState stateService play Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::syncState currentStatus play Jul 20 15:24:34 volumio volumio[485]: info: Received an update from plugin. extracting info from payload Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: ControllerMpd::pushState Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::servicePushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1019 Kbps","isStreaming":false,"title":"It's a Sin ","artist":"Pet Shop Boys","album":"Discography The Complete Singles Collection","uri":"NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac","trackType":"flac"} Jul 20 15:24:34 volumio volumio[485]: verbose: CURRENT POSITION 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::syncState stateService play Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::syncState currentStatus play Jul 20 15:24:34 volumio volumio[485]: info: Received an update from plugin. extracting info from payload Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:34 volumio volumio[485]: info: ------------------------------ 55ms Jul 20 15:24:34 volumio volumio[485]: info: ------------------------------ 53ms Jul 20 15:24:34 volumio volumio[485]: info: ------------------------------ 55ms Jul 20 15:24:36 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:24:36 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:24:43 volumio sudo[10116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 20 15:24:43 volumio sudo[10116]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 15:24:43 volumio sudo[10116]: pam_unix(sudo:session): session closed for user root Jul 20 15:24:43 volumio sudo[10119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 20 15:24:43 volumio sudo[10119]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 15:24:43 volumio sudo[10119]: pam_unix(sudo:session): session closed for user root Jul 20 15:24:43 volumio volumio[485]: verbose: New Socket.io Connection to 192.168.0.94 from 192.168.0.209 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Mobile Safari/537.36 EdgA/126.0.0.0 Total Clients: 6 Jul 20 15:24:43 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::volumioGetVisibleSources Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::volumioGetState Jul 20 15:24:44 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::volumioGetQueue Jul 20 15:24:44 volumio volumio[485]: info: CoreStateMachine::getQueue Jul 20 15:24:44 volumio volumio[485]: info: CorePlayQueue::getQueue Jul 20 15:24:44 volumio volumio[485]: info: Listing playlists Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 20 15:24:44 volumio volumio[485]: info: Received Get System Info Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 20 15:24:44 volumio volumio[485]: info: Discovery: Getting this device information Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::volumioGetState Jul 20 15:24:44 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::volumioGetState Jul 20 15:24:44 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 20 15:24:44 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 20 15:24:45 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 20 15:24:45 volumio volumio[485]: info: Received Get System Info Jul 20 15:24:45 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 20 15:24:45 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 20 15:24:45 volumio volumio[485]: info: Discovery: Getting this device information Jul 20 15:24:45 volumio volumio[485]: info: CoreCommandRouter::volumioGetState Jul 20 15:24:45 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:45 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 20 15:24:46 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::volumioPause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::stPlaybackTimer Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::servicePause Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::servicePause Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::pause Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand pause Jul 20 15:24:46 volumio volumio[485]: info: Jul 20 15:24:46 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand pause took 3 milliseconds Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::getState Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand status Jul 20 15:24:46 volumio volumio[485]: info: Jul 20 15:24:46 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::getState Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand status Jul 20 15:24:46 volumio volumio[485]: info: Jul 20 15:24:46 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::getState Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand status Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand status took 5 milliseconds Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand status took 3 milliseconds Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand status took 1 milliseconds Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::parseState Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::parseState Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::parseState Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 20 15:24:46 volumio volumio[485]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::parseTrackInfo Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::parseTrackInfo Jul 20 15:24:46 volumio volumio[485]: verbose: ControllerMpd::parseTrackInfo Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::pushState Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::servicePushState Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":12683,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"779 Kbps","isStreaming":false,"title":"It's a Sin ","artist":"Pet Shop Boys","album":"Discography The Complete Singles Collection","uri":"NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac","trackType":"flac"} Jul 20 15:24:46 volumio volumio[485]: verbose: CURRENT POSITION 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::syncState stateService pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::syncState currentStatus pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::stPlaybackTimer Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::pushState Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::servicePushState Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":12683,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"779 Kbps","isStreaming":false,"title":"It's a Sin ","artist":"Pet Shop Boys","album":"Discography The Complete Singles Collection","uri":"NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac","trackType":"flac"} Jul 20 15:24:46 volumio volumio[485]: verbose: CURRENT POSITION 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::syncState stateService pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::syncState currentStatus pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::stPlaybackTimer Jul 20 15:24:46 volumio volumio[485]: info: ControllerMpd::pushState Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::servicePushState Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":12683,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"779 Kbps","isStreaming":false,"title":"It's a Sin ","artist":"Pet Shop Boys","album":"Discography The Complete Singles Collection","uri":"NAS/lenovo-nas/POP/Pet.Shop.Boys/Pet.Shop.Boys.-.[Discography.The.Complete.Singles.Collection].专辑.(flac)/Pet Shop Boys - It's a Sin.flac","trackType":"flac"} Jul 20 15:24:46 volumio volumio[485]: verbose: CURRENT POSITION 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::syncState stateService pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::syncState currentStatus pause Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:24:46 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:24:46 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:24:46 volumio volumio[485]: info: CoreStateMachine::stPlaybackTimer Jul 20 15:24:46 volumio volumio[485]: info: ------------------------------ 30ms Jul 20 15:24:46 volumio volumio[485]: info: ------------------------------ 27ms Jul 20 15:24:46 volumio volumio[485]: info: ------------------------------ 26ms Jul 20 15:24:47 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:24:47 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:24:53 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:24:53 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:24:57 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:25:03 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:25:04 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 20 15:25:04 volumio volumio[485]: info: CURURI: music-library/NAS/lenovo-nas/JAZZ Jul 20 15:25:04 volumio volumio[485]: info: Preload queue cleared Jul 20 15:25:08 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:25:08 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:25:09 volumio nmbd[676]: [2024/07/20 15:25:09.669231, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 20 15:25:09 volumio nmbd[676]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.94 for name WORKGROUP<1d>. Jul 20 15:25:09 volumio nmbd[676]: This response was from IP 192.168.0.2, reporting an IP address of 192.168.0.2. Jul 20 15:25:16 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:25:16 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:25:18 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:25:26 volumio volumio[485]: info: MyVolumio login type: Token Jul 20 15:25:33 volumio volumio[485]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jul 20 15:25:33 volumio volumio[485]: info: Retrying Login Due to Network Error Jul 20 15:25:34 volumio volumio[485]: info: Preload queue cleared Jul 20 15:25:34 volumio volumio[485]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::ClearQueue Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::stop Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::updateTrackBlock Jul 20 15:25:34 volumio volumio[485]: info: CorePlayQueue::getTrackBlock Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::stPlaybackTimer Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::pushState Jul 20 15:25:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:25:34 volumio volumio[485]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 15:25:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushState Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::serviceStop Jul 20 15:25:34 volumio volumio[485]: info: CorePlayQueue::getTrack 6 Jul 20 15:25:34 volumio volumio[485]: info: CoreCommandRouter::serviceStop Jul 20 15:25:34 volumio volumio[485]: info: ControllerMpd::stop Jul 20 15:25:34 volumio volumio[485]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 15:25:34 volumio volumio[485]: info: CorePlayQueue::clearPlayQueue Jul 20 15:25:34 volumio volumio[485]: info: CorePlayQueue::saveQueue Jul 20 15:25:34 volumio volumio[485]: info: CoreCommandRouter::volumioPushQueue Jul 20 15:25:34 volumio volumio[485]: info: CoreStateMachine::addQueueItems Jul 20 15:25:34 volumio volumio[485]: info: CorePlayQueue::addQueueItems Jul 20 15:25:34 volumio volumio[485]: info: Preload queue cleared Jul 20 15:25:34 volumio volumio[485]: info: Adding Item to queue: music-library/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac) Jul 20 15:25:34 volumio volumio[485]: info: Exploding uri music-library/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac) in service mpd Jul 20 15:25:34 volumio volumio[485]: info: Jul 20 15:25:34 volumio volumio[485]: ---------------------------- MPD announces state update: player Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F01%20-%20It%20Might%20As%20Well%20Be%20Spring.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/01 - It Might As Well Be Spring.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F02%20-%20Countdown.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/02 - Countdown.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F03%20-%20My%20Romance.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/03 - My Romance.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F04%20-%20Angst.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/04 - Angst.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F05%20-%20Young%20Werther.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/05 - Young Werther.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F06%20-%20Prelude%20To%20A%20Kiss.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/06 - Prelude To A Kiss.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F07%20-%20London%20Blues.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/07 - London Blues.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F08%20-%20From%20This%20Moment%20On.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/08 - From This Moment On.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2F09%20-%20Say%20Goodbye.flac&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/09 - Say Goodbye.flac Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2FIntroducing%20Brad%20Mehldau.cue&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/Introducing Brad Mehldau.cue Jul 20 15:25:34 volumio volumio[485]: info: ALBUMART /albumart?cacheid=959&web=Brad%20Mehldau/Introducing%20Brad%20Mehldau/extralarge&path=%2Fmnt%2FNAS%2Flenovo-nas%2FJAZZ%2FBrad.Mehldau.-.%5BIntroducing.Brad.Mehldau%5D.%E4%B8%93%E8%BE%91.(Flac)%2FIntroducing%20Brad%20Mehldau.cue&metadata=false Jul 20 15:25:34 volumio volumio[485]: info: URI /mnt/NAS/lenovo-nas/JAZZ/Brad.Mehldau.-.[Introducing.Brad.Mehldau].专辑.(Flac)/Introducing Brad Mehldau.cue Jul 20 15:25:34 volumio volumio[485]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 20 15:25:34 volumio volumio[485]: Error: Unable to resolve or reject the same promise twice Jul 20 15:25:34 volumio volumio[485]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 20 15:25:34 volumio volumio[485]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jul 20 15:25:34 volumio volumio[485]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 20 15:25:34 volumio volumio[485]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 20 15:25:34 volumio volumio[485]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 20 15:25:34 volumio volumio[485]: at Socket.emit (events.js:400:28) Jul 20 15:25:34 volumio volumio[485]: at addChunk (internal/streams/readable.js:293:12) Jul 20 15:25:34 volumio volumio[485]: at readableAddChunk (internal/streams/readable.js:263:11) Jul 20 15:25:34 volumio volumio[485]: at Socket.Readable.push (internal/streams/readable.js:206:10) Jul 20 15:25:34 volumio volumio[485]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jul 20 15:25:34 volumio volumio[485]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 20 15:25:35 volumio sudo[10183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-20 15:24 Jul 20 15:25:35 volumio sudo[10183]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="9552505bba4239c163ac9ee7b0b87a56e0dd0574" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="3d3fc502273a5c173ba19f72c1a952bdb2bdd3b0" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 Feb 2024 07:28:53 PM CET" VOLUMIO_VERSION="3.616" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="f11d51aa83fa91106999927181e8c0f7"