-- Logs begin at Fri 2025-07-18 11:00:41 +04, end at Fri 2025-07-18 12:38:28 +04. -- Jul 18 12:37:01 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:01 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:01 sunset-mall CRON[15042]: pam_unix(cron:session): session opened for user root by (uid=0) Jul 18 12:37:01 sunset-mall CRON[15043]: (root) CMD (/root/ipray.sh 3) Jul 18 12:37:03 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:03 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:05 sunset-mall volumiologrotate[653]: ls: cannot access '/var/log/samba/log.wb-SUNSET': No such file or directory Jul 18 12:37:05 sunset-mall volumiologrotate[653]: ls: cannot access 'MALL': No such file or directory Jul 18 12:37:05 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:05 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:07 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:07 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:10 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:10 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:12 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:12 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:14 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:14 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:20 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:20 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:23 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:23 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:27 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:27 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:29 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:29 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:31 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:31 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:33 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:33 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:36 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:36 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:36 sunset-mall cron[659]: 2025-07-18 12:37:36 1ucgb2-00044x-NC Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 Jul 18 12:37:36 sunset-mall cron[659]: 2025-07-18 12:37:36 1ucgb2-00044x-NC <= root@volumio U=root P=local S=3497 Jul 18 12:37:36 sunset-mall cron[659]: 2025-07-18 12:37:36 1ucgb2-00044x-NC Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 Jul 18 12:37:36 sunset-mall cron[659]: exim: could not open panic log - aborting: see message(s) above Jul 18 12:37:36 sunset-mall exim[15683]: 2025-07-18 12:37:36 1ucgb2-00044x-NC <= root@volumio U=root P=local S=3497 Jul 18 12:37:36 sunset-mall exim[15683]: 2025-07-18 12:37:36 1ucgb2-00044x-NC Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=118 egid=124 Jul 18 12:37:36 sunset-mall exim[15683]: exim: could not open panic log - aborting: see message(s) above Jul 18 12:37:36 sunset-mall CRON[15042]: (root) MAIL (mailed 2953 bytes of output but got status 0x0001 from MTA ) Jul 18 12:37:36 sunset-mall CRON[15042]: pam_unix(cron:session): session closed for user root Jul 18 12:37:38 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:38 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:40 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:40 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:42 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:42 sunset-mall volumio[1333]: verbose: New Socket.io Connection to 192.168.2.125 from 192.168.2.1 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_12_6) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/103.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:42 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetVisibleSources Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 18 12:37:42 sunset-mall volumio[1333]: info: Listing playlists Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetQueue Jul 18 12:37:42 sunset-mall volumio[1333]: info: CoreStateMachine::getQueue Jul 18 12:37:42 sunset-mall volumio[1333]: info: CorePlayQueue::getQueue Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:43 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetVisibleSources Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 18 12:37:43 sunset-mall volumio[1333]: info: Listing playlists Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetQueue Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreStateMachine::getQueue Jul 18 12:37:43 sunset-mall volumio[1333]: info: CorePlayQueue::getQueue Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:43 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetVisibleSources Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 18 12:37:43 sunset-mall volumio[1333]: info: Listing playlists Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetQueue Jul 18 12:37:43 sunset-mall volumio[1333]: info: CoreStateMachine::getQueue Jul 18 12:37:43 sunset-mall volumio[1333]: info: CorePlayQueue::getQueue Jul 18 12:37:46 sunset-mall volumio[1333]: Upnp client error: Error: This socket has been ended by the other party Jul 18 12:37:46 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:46 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:48 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:48 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:50 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:50 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:52 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:52 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:54 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:54 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:56 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:56 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:37:59 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:37:59 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:01 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:01 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:01 sunset-mall CRON[15898]: pam_unix(cron:session): session opened for user root by (uid=0) Jul 18 12:38:01 sunset-mall CRON[15899]: pam_unix(cron:session): session opened for user root by (uid=0) Jul 18 12:38:01 sunset-mall CRON[15900]: (root) CMD (/root/ipray.sh 3) Jul 18 12:38:01 sunset-mall CRON[15901]: (root) CMD (/root/mp-sw.sh 2) Jul 18 12:38:01 sunset-mall CRON[15899]: pam_unix(cron:session): session closed for user root Jul 18 12:38:03 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:03 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:05 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:05 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:05 sunset-mall volumiologrotate[653]: ls: cannot access '/var/log/samba/log.wb-SUNSET': No such file or directory Jul 18 12:38:05 sunset-mall volumiologrotate[653]: ls: cannot access 'MALL': No such file or directory Jul 18 12:38:07 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:07 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:08 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:08 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:08 sunset-mall volumio[1333]: info: Prefetching next song Jul 18 12:38:08 sunset-mall volumio[1333]: info: DOING PREFETCH IN MPD Jul 18 12:38:08 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/2 Piano jazz/01 Chelsea Bridge 1.mp3" Jul 18 12:38:08 sunset-mall volumio[1333]: info: Jul 18 12:38:08 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:08 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:08 sunset-mall volumio[1333]: info: sendMpdCommand add "INTERNAL/2 Piano jazz/01 Chelsea Bridge 1.mp3" took 4 milliseconds Jul 18 12:38:08 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 18 12:38:08 sunset-mall volumio[1333]: info: Jul 18 12:38:08 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:08 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:08 sunset-mall volumio[1333]: info: Jul 18 12:38:08 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:08 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:08 sunset-mall volumio[1333]: info: ------------------------------ 23ms Jul 18 12:38:08 sunset-mall volumio[1333]: info: sendMpdCommand consume 1 took 45 milliseconds Jul 18 12:38:08 sunset-mall volumio[1333]: info: ------------------------------ 43ms Jul 18 12:38:08 sunset-mall volumio[1333]: info: ------------------------------ 42ms Jul 18 12:38:09 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:09 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:12 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:12 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 3 Jul 18 12:38:12 sunset-mall volumio[1333]: info: CoreStateMachine::startPlaybackTimer Jul 18 12:38:12 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:13 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:13 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:13 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:13 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:14 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:14 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:14 sunset-mall volumio[1333]: info: VolumeController::SetAlsaVolume15 Jul 18 12:38:14 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:14 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:14 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:14 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:15 sunset-mall volumio[1333]: info: VolumeController::SetAlsaVolume25 Jul 18 12:38:15 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:15 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:15 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:15 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:15 sunset-mall volumio[1333]: info: VolumeController::SetAlsaVolume45 Jul 18 12:38:15 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:15 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:15 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:15 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio-volume-sync.sh[755]: Simple mixer control 'PCM',0 Jul 18 12:38:16 sunset-mall volumio-volume-sync.sh[755]: Capabilities: pvolume pvolume-joined pswitch pswitch-joined Jul 18 12:38:16 sunset-mall volumio-volume-sync.sh[755]: Playback channels: Mono Jul 18 12:38:16 sunset-mall volumio-volume-sync.sh[755]: Limits: Playback -10239 - 400 Jul 18 12:38:16 sunset-mall volumio-volume-sync.sh[755]: Mono: Playback -5451 [45%] [-54.51dB] [on] Jul 18 12:38:16 sunset-mall volumio[1333]: info: Jul 18 12:38:16 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:16 sunset-mall volumio[1333]: info: Jul 18 12:38:16 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:16 sunset-mall volumio[1333]: info: Jul 18 12:38:16 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand status took 10 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand status took 7 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand status took 4 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":304411,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:16 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":304411,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:16 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":304411,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:16 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: ------------------------------ 167ms Jul 18 12:38:16 sunset-mall volumio[1333]: info: ------------------------------ 165ms Jul 18 12:38:16 sunset-mall volumio[1333]: info: ------------------------------ 161ms Jul 18 12:38:16 sunset-mall volumio[1333]: info: Jul 18 12:38:16 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:16 sunset-mall volumio[1333]: info: Jul 18 12:38:16 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:16 sunset-mall volumio[1333]: info: Jul 18 12:38:16 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand status took 10 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand status took 7 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand status took 5 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":304537,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:16 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":304537,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:16 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":304537,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:16 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:16 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:16 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:16 sunset-mall volumio[1333]: info: ------------------------------ 128ms Jul 18 12:38:16 sunset-mall volumio[1333]: info: ------------------------------ 127ms Jul 18 12:38:16 sunset-mall volumio[1333]: info: ------------------------------ 125ms Jul 18 12:38:18 sunset-mall volumio[1333]: info: VolumeController::SetAlsaVolume50 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio-volume-sync.sh[755]: Simple mixer control 'PCM',0 Jul 18 12:38:18 sunset-mall volumio-volume-sync.sh[755]: Capabilities: pvolume pvolume-joined pswitch pswitch-joined Jul 18 12:38:18 sunset-mall volumio-volume-sync.sh[755]: Playback channels: Mono Jul 18 12:38:18 sunset-mall volumio-volume-sync.sh[755]: Limits: Playback -10239 - 400 Jul 18 12:38:18 sunset-mall volumio-volume-sync.sh[755]: Mono: Playback -4919 [50%] [-49.19dB] [on] Jul 18 12:38:18 sunset-mall volumio[1333]: info: Jul 18 12:38:18 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:18 sunset-mall volumio[1333]: info: Jul 18 12:38:18 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:18 sunset-mall volumio[1333]: info: Jul 18 12:38:18 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand status took 7 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand status took 4 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand status took 2 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":306537,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:18 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":306537,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:18 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":306537,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:18 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: ------------------------------ 103ms Jul 18 12:38:18 sunset-mall volumio[1333]: info: ------------------------------ 102ms Jul 18 12:38:18 sunset-mall volumio[1333]: info: ------------------------------ 101ms Jul 18 12:38:18 sunset-mall volumio[1333]: info: Jul 18 12:38:18 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:18 sunset-mall volumio[1333]: info: Jul 18 12:38:18 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:18 sunset-mall volumio[1333]: info: Jul 18 12:38:18 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: mixer Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand status took 10 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand status took 6 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand status took 3 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":306788,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:18 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":306788,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:18 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:18 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:18 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:18 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:19 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":306788,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:19 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:19 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:19 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:19 sunset-mall volumio[1333]: info: ------------------------------ 133ms Jul 18 12:38:19 sunset-mall volumio[1333]: info: ------------------------------ 131ms Jul 18 12:38:19 sunset-mall volumio[1333]: info: ------------------------------ 128ms Jul 18 12:38:20 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:20 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:20 sunset-mall volumio[1333]: info: Jul 18 12:38:20 sunset-mall volumio[1333]: ---------------------------- Client requests Volume 0 Jul 18 12:38:20 sunset-mall volumio[1333]: info: VolumeController::SetAlsaVolume0 Jul 18 12:38:20 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:20 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:20 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:20 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:23 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:23 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: options Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 70ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 66 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 66ms Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: options Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 97 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 96ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 94 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 39 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 40 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 4 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 4 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService stop Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::play index undefined Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":34,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"From here I can see you","artist":"Tim Hesse","album":"Four Walls Talking - EP","uri":"2 Piano jazz/01 From here I can see you 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus stop Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 151ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 215ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: options Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 192 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 174 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 182ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 170 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 169 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 162 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 41ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 39 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 37 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":34,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"From here I can see you","artist":"Tim Hesse","album":"Four Walls Talking - EP","uri":"2 Piano jazz/01 From here I can see you 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":2,"seek":34,"duration":242,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"From here I can see you","artist":"Tim Hesse","album":"Four Walls Talking - EP","uri":"2 Piano jazz/01 From here I can see you 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 372ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 369ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces system playlist update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Ignoring MPD Status Update Jul 18 12:38:24 sunset-mall volumio[1333]: info: Jul 18 12:38:24 sunset-mall volumio[1333]: ---------------------------- MPD announces state update: player Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::getState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand status Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 161 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 149 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 147 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 145 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 143 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 143 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 59 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 59ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand status took 51 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseState Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":0,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":0,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":0,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":null,"isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":857,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":857,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:24 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 547ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 522ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 522ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 380ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: ------------------------------ 377ms Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 194 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 192 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: info: sendMpdCommand playlistinfo took 192 milliseconds Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: verbose: ControllerMpd::parseTrackInfo Jul 18 12:38:24 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:24 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":1108,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:25 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:25 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":1108,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:25 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:25 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: ControllerMpd::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::servicePushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: verbose: STATE SERVICE {"status":"play","position":3,"seek":1234,"duration":312,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":true,"bitrate":"192 Kbps","isStreaming":false,"title":"It Never Entered My Mind","artist":"Billy Childs","album":"Acceptance","uri":"2 Piano jazz/05 It Never Entered My Mind 1.mp3","trackType":"mp3"} Jul 18 12:38:25 sunset-mall volumio[1333]: verbose: CURRENT POSITION 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::syncState stateService play Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::syncState currentStatus play Jul 18 12:38:25 sunset-mall volumio[1333]: info: Received an update from plugin. extracting info from payload Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreStateMachine::pushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioPushState Jul 18 12:38:25 sunset-mall volumio[1333]: info: ------------------------------ 516ms Jul 18 12:38:25 sunset-mall volumio[1333]: info: ------------------------------ 394ms Jul 18 12:38:25 sunset-mall volumio[1333]: info: ------------------------------ 392ms Jul 18 12:38:25 sunset-mall volumio[1333]: info: CoreCommandRouter::volumioGetState Jul 18 12:38:25 sunset-mall volumio[1333]: info: CorePlayQueue::getTrack 5 Jul 18 12:38:26 sunset-mall volumio[1333]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 12:38:26 sunset-mall volumio[1333]: Error [ERR_TLS_CERT_ALTNAME_INVALID]: Hostname/IP does not match certificate's altnames: Host: lastfm.freetls.fastly.net. is not in the cert's altnames: DNS:retail.soundyoucanfeel.me Jul 18 12:38:26 sunset-mall volumio[1333]: at Object.checkServerIdentity (tls.js:297:12) Jul 18 12:38:26 sunset-mall volumio[1333]: at TLSSocket.onConnectSecure (_tls_wrap.js:1507:27) Jul 18 12:38:26 sunset-mall volumio[1333]: at TLSSocket.emit (events.js:315:20) Jul 18 12:38:26 sunset-mall volumio[1333]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Jul 18 12:38:26 sunset-mall volumio[1333]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Jul 18 12:38:26 sunset-mall volumio[1333]: reason: "Host: lastfm.freetls.fastly.net. is not in the cert's altnames: DNS:retail.soundyoucanfeel.me", Jul 18 12:38:26 sunset-mall volumio[1333]: host: 'lastfm.freetls.fastly.net', Jul 18 12:38:26 sunset-mall volumio[1333]: cert: { Jul 18 12:38:26 sunset-mall volumio[1333]: subject: [Object: null prototype] { CN: 'retail.soundyoucanfeel.me' }, Jul 18 12:38:26 sunset-mall volumio[1333]: issuer: [Object: null prototype] { C: 'US', O: "Let's Encrypt", CN: 'E6' }, Jul 18 12:38:26 sunset-mall volumio[1333]: subjectaltname: 'DNS:retail.soundyoucanfeel.me', Jul 18 12:38:26 sunset-mall volumio[1333]: infoAccess: [Object: null prototype] { Jul 18 12:38:26 sunset-mall volumio[1333]: 'OCSP - URI': [Array], Jul 18 12:38:26 sunset-mall volumio[1333]: 'CA Issuers - URI': [Array] Jul 18 12:38:26 sunset-mall volumio[1333]: }, Jul 18 12:38:26 sunset-mall volumio[1333]: bits: 384, Jul 18 12:38:26 sunset-mall volumio[1333]: pubkey: , Jul 18 12:38:26 sunset-mall volumio[1333]: asn1Curve: 'secp384r1', Jul 18 12:38:26 sunset-mall volumio[1333]: nistCurve: 'P-384', Jul 18 12:38:26 sunset-mall volumio[1333]: valid_from: 'Apr 28 03:36:45 2025 GMT', Jul 18 12:38:26 sunset-mall volumio[1333]: valid_to: 'Jul 27 03:36:44 2025 GMT', Jul 18 12:38:26 sunset-mall volumio[1333]: fingerprint: '2C:20:BE:9A:92:8E:B4:98:EB:F5:6A:8C:E4:D8:8C:F4:2F:F5:12:2C', Jul 18 12:38:26 sunset-mall volumio[1333]: fingerprint256: '3B:B8:8D:75:E4:6D:1F:40:E8:92:34:C3:C6:B6:AC:BB:25:4B:C7:29:AD:F6:D0:D0:F4:F5:1E:1D:EE:11:9F:C0', Jul 18 12:38:26 sunset-mall volumio[1333]: ext_key_usage: [ '1.3.6.1.5.5.7.3.1', '1.3.6.1.5.5.7.3.2' ], Jul 18 12:38:26 sunset-mall volumio[1333]: serialNumber: '057C433BC5FCC264600F5E0C05A8F648F712', Jul 18 12:38:26 sunset-mall volumio[1333]: raw: , Jul 18 12:38:26 sunset-mall volumio[1333]: issuerCertificate: { Jul 18 12:38:26 sunset-mall volumio[1333]: subject: [Object: null prototype], Jul 18 12:38:26 sunset-mall volumio[1333]: issuer: [Object: null prototype], Jul 18 12:38:26 sunset-mall volumio[1333]: infoAccess: [Object: null prototype], Jul 18 12:38:26 sunset-mall volumio[1333]: bits: 384, Jul 18 12:38:26 sunset-mall volumio[1333]: pubkey: , Jul 18 12:38:26 sunset-mall volumio[1333]: asn1Curve: 'secp384r1', Jul 18 12:38:26 sunset-mall volumio[1333]: nistCurve: 'P-384', Jul 18 12:38:26 sunset-mall volumio[1333]: valid_from: 'Mar 13 00:00:00 2024 GMT', Jul 18 12:38:26 sunset-mall volumio[1333]: valid_to: 'Mar 12 23:59:59 2027 GMT', Jul 18 12:38:26 sunset-mall volumio[1333]: fingerprint: 'C9:4D:C4:83:1A:90:1A:9F:EC:0F:B4:9B:71:BD:49:B5:AA:D4:FA:D0', Jul 18 12:38:26 sunset-mall volumio[1333]: fingerprint256: '76:E9:E2:88:AA:FC:0E:37:F4:39:0C:BF:94:6A:AD:99:7D:5C:1C:90:1B:3C:E5:13:D3:D8:FA:DB:AB:E2:AB:85', Jul 18 12:38:26 sunset-mall volumio[1333]: ext_key_usage: [Array], Jul 18 12:38:26 sunset-mall volumio[1333]: serialNumber: 'B0573E9173972770DBB487CB3A452B38', Jul 18 12:38:26 sunset-mall volumio[1333]: raw: , Jul 18 12:38:26 sunset-mall volumio[1333]: issuerCertificate: [Object] Jul 18 12:38:26 sunset-mall volumio[1333]: } Jul 18 12:38:26 sunset-mall volumio[1333]: }, Jul 18 12:38:26 sunset-mall volumio[1333]: code: 'ERR_TLS_CERT_ALTNAME_INVALID' Jul 18 12:38:26 sunset-mall volumio[1333]: } Jul 18 12:38:26 sunset-mall volumio[1333]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 12:38:28 sunset-mall sudo[16441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-18 12:37 Jul 18 12:38:28 sunset-mall sudo[16441]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"