-- Logs begin at Sat 2025-04-19 05:49:33 UTC, end at Sat 2025-04-19 06:32:58 UTC. --
Apr 19 06:31:00 volumio sudo[13289]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:00 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 3 ,retrying in 5 seconds
Apr 19 06:31:00 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 19 06:31:00 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Apr 19 06:31:00 volumio kernel: CIFS: Attempting to mount //192.168.0.104/音ä¹
Apr 19 06:31:00 volumio sudo[13294]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:00 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 3 ,retrying in 5 seconds
Apr 19 06:31:00 volumio kernel: CIFS: Attempting to mount //192.168.0.105/音ä¹
Apr 19 06:31:00 volumio smbd[13378]: [2025/04/19 06:31:00.892746, 0] ../source3/param/loadparm.c:3364(process_usershare_file)
Apr 19 06:31:00 volumio smbd[13378]: process_usershare_file: stat of /var/lib/samba/usershares/éŸ³ä¹ failed. Permission denied
Apr 19 06:31:00 volumio smbd[13378]: [2025/04/19 06:31:00.893554, 0] ../source3/param/loadparm.c:3364(process_usershare_file)
Apr 19 06:31:00 volumio smbd[13378]: process_usershare_file: stat of /var/lib/samba/usershares/éŸ³ä¹ failed. No such file or directory
Apr 19 06:31:00 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.0.105\音ä¹
Apr 19 06:31:00 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2
Apr 19 06:31:00 volumio kernel: CIFS: Attempting to mount //192.168.0.103/音ä¹
Apr 19 06:31:00 volumio sudo[13299]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:00 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 3 ,retrying in 5 seconds
Apr 19 06:31:01 volumio sudo[13305]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:01 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 3 ,retrying in 5 seconds
Apr 19 06:31:01 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 19 06:31:01 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -111
Apr 19 06:31:01 volumio volumio[12999]: info: BOOT COMPLETED
Apr 19 06:31:05 volumio sudo[13381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.165/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:05 volumio sudo[13381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:05 volumio kernel: CIFS: Attempting to mount //192.168.3.165/音ä¹
Apr 19 06:31:05 volumio sudo[13384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.104/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:05 volumio sudo[13384]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:05 volumio sudo[13389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.105/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:05 volumio sudo[13389]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:06 volumio sudo[13396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.103/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:06 volumio sudo[13396]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::volumioNext
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::next
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::stop
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::stPlaybackTimer
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::updateTrackBlock
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrackBlock
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 185
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::serviceStop
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 185
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::serviceStop
Apr 19 06:31:15 volumio volumio[12999]: info: ControllerMpd::stop
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand stop took 18 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::play index undefined
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::startPlaybackTimer
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::clearAddPlayTracks NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::updateTrackBlock
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrackBlock
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:15 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:15 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand status took 4 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand stop took 3 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand status took 2 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand status took 2 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:15 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand clear took 2 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand add "NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac"
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:15 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:15 volumio volumio[12999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"How Do I Live","artist":"Trisha Yearwood","album":"Songbook (A Collection of Hits)","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/004.Trisha Yearwood - How Do I Live.flac","trackType":"flac"}
Apr 19 06:31:15 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::syncState stateService stop
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:15 volumio volumio[12999]: info: No code
Apr 19 06:31:15 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:15 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:15 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:15 volumio volumio[12999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 06:31:15 volumio volumio[12999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 31ms
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 29ms
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 28ms
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:15 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:15 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:15 volumio volumio[12999]: error: updateQueue error: null
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:15 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 26ms
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand add "NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac" took 25 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 4ms
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 4ms
Apr 19 06:31:15 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:15 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:15 volumio volumio[12999]: info:
Apr 19 06:31:15 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:15 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 7ms
Apr 19 06:31:15 volumio volumio[12999]: info: sendMpdCommand play took 5 milliseconds
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 4ms
Apr 19 06:31:15 volumio volumio[12999]: info: ------------------------------ 6ms
Apr 19 06:31:16 volumio volumio[12999]: info:
Apr 19 06:31:16 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:16 volumio volumio[12999]: info:
Apr 19 06:31:16 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:16 volumio volumio[12999]: info:
Apr 19 06:31:16 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:16 volumio volumio[12999]: info:
Apr 19 06:31:16 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand status took 42 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand status took 41 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand status took 40 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:16 volumio volumio[12999]: info:
Apr 19 06:31:16 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:16 volumio volumio[12999]: info:
Apr 19 06:31:16 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand status took 4 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand status took 2 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand status took 1 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:16 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:16 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:16 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:16 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:16 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: ------------------------------ 62ms
Apr 19 06:31:16 volumio volumio[12999]: info: ------------------------------ 87ms
Apr 19 06:31:16 volumio volumio[12999]: info: ------------------------------ 88ms
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 44 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 44 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 43 milliseconds
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:16 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:16 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:16 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:16 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:16 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"824 Kbps","isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:16 volumio volumio[12999]: verbose: CURRENT POSITION 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:16 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:16 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:16 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:16 volumio volumio[12999]: info: ------------------------------ 78ms
Apr 19 06:31:16 volumio volumio[12999]: info: ------------------------------ 76ms
Apr 19 06:31:16 volumio sudo[13381]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:16 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 4 ,retrying in 5 seconds
Apr 19 06:31:16 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 19 06:31:16 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Apr 19 06:31:16 volumio kernel: CIFS: Attempting to mount //192.168.0.104/音ä¹
Apr 19 06:31:16 volumio sudo[13384]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:16 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 4 ,retrying in 5 seconds
Apr 19 06:31:16 volumio kernel: CIFS: Attempting to mount //192.168.0.105/音ä¹
Apr 19 06:31:16 volumio smbd[13419]: [2025/04/19 06:31:16.252293, 0] ../source3/param/loadparm.c:3364(process_usershare_file)
Apr 19 06:31:16 volumio smbd[13419]: process_usershare_file: stat of /var/lib/samba/usershares/éŸ³ä¹ failed. Permission denied
Apr 19 06:31:16 volumio smbd[13419]: [2025/04/19 06:31:16.252643, 0] ../source3/param/loadparm.c:3364(process_usershare_file)
Apr 19 06:31:16 volumio smbd[13419]: process_usershare_file: stat of /var/lib/samba/usershares/éŸ³ä¹ failed. No such file or directory
Apr 19 06:31:16 volumio sudo[13389]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:16 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.0.105\音ä¹
Apr 19 06:31:16 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2
Apr 19 06:31:16 volumio kernel: CIFS: Attempting to mount //192.168.0.103/音ä¹
Apr 19 06:31:16 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 4 ,retrying in 5 seconds
Apr 19 06:31:16 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 19 06:31:16 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -111
Apr 19 06:31:16 volumio sudo[13396]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:16 volumio volumio[12999]: info: Cannot mount NAS éŸ³ä¹ at system boot, trial number 4 ,retrying in 5 seconds
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioNext
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::next
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::stop
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::stPlaybackTimer
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::updateTrackBlock
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrackBlock
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::serviceStop
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 147
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::serviceStop
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::stop
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 06:31:17 volumio volumio[12999]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Atomic%20Kitten/Ladies%20Night/6e082df7-7460-4bcf-b589-ca02eda15f50.png'
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand stop took 57 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::play index undefined
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::startPlaybackTimer
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::clearAddPlayTracks NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::updateTrackBlock
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrackBlock
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 5 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand stop took 4 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 2 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:17 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand clear took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand add "NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac"
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Everything Goes Around","artist":"Atomic Kitten","album":"Ladies Night","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD08/006.Atomic Kitten - Everything Goes Around.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService stop
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: No code
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 06:31:17 volumio volumio[12999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 35ms
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 33ms
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:17 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:17 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:17 volumio volumio[12999]: error: updateQueue error: null
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:17 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 32ms
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand add "NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac" took 30 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 4ms
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 5ms
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 6ms
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:17 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:31:17 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand play took 10 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 3ms
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 2ms
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 27 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 28 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 27 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 1 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4 In The Morning","artist":"Gwen Stefani","album":"The Sweet Escape","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 31ms
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info:
Apr 19 06:31:17 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 1 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand status took 1 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"155 Kbps","isStreaming":false,"title":"4 In The Morning","artist":"Gwen Stefani","album":"The Sweet Escape","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:17 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":227,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"155 Kbps","isStreaming":false,"title":"4 In The Morning","artist":"Gwen Stefani","album":"The Sweet Escape","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:17 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"4 In The Morning","artist":"Gwen Stefani","album":"The Sweet Escape","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:17 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 62ms
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 38ms
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 33 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 33 milliseconds
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"4 In The Morning","artist":"Gwen Stefani","album":"The Sweet Escape","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:17 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"4 In The Morning","artist":"Gwen Stefani","album":"The Sweet Escape","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD10/016.Gwen Stefani - 4 In The Morning.flac","trackType":"flac"}
Apr 19 06:31:17 volumio volumio[12999]: verbose: CURRENT POSITION 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:31:17 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:31:17 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:31:17 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 54ms
Apr 19 06:31:17 volumio volumio[12999]: info: ------------------------------ 55ms
Apr 19 06:31:21 volumio sudo[13435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.165/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:21 volumio sudo[13435]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:21 volumio kernel: CIFS: Attempting to mount //192.168.3.165/音ä¹
Apr 19 06:31:21 volumio sudo[13438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.104/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:21 volumio sudo[13438]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:21 volumio sudo[13443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.105/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:21 volumio sudo[13443]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:21 volumio sudo[13450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.103/éŸ³ä¹ /mnt/NAS/音ä¹
Apr 19 06:31:21 volumio sudo[13450]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 19 06:31:26 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 19 06:31:31 volumio sudo[13435]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:31 volumio volumio[12999]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 19 06:31:31 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 19 06:31:31 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Apr 19 06:31:31 volumio kernel: CIFS: Attempting to mount //192.168.0.104/音ä¹
Apr 19 06:31:31 volumio sudo[13438]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:31 volumio volumio[12999]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 19 06:31:31 volumio kernel: CIFS: Attempting to mount //192.168.0.105/音ä¹
Apr 19 06:31:31 volumio smbd[13474]: [2025/04/19 06:31:31.612583, 0] ../source3/param/loadparm.c:3364(process_usershare_file)
Apr 19 06:31:31 volumio smbd[13474]: process_usershare_file: stat of /var/lib/samba/usershares/éŸ³ä¹ failed. Permission denied
Apr 19 06:31:31 volumio smbd[13474]: [2025/04/19 06:31:31.613365, 0] ../source3/param/loadparm.c:3364(process_usershare_file)
Apr 19 06:31:31 volumio smbd[13474]: process_usershare_file: stat of /var/lib/samba/usershares/éŸ³ä¹ failed. No such file or directory
Apr 19 06:31:31 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.0.105\音ä¹
Apr 19 06:31:31 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2
Apr 19 06:31:31 volumio kernel: CIFS: Attempting to mount //192.168.0.103/音ä¹
Apr 19 06:31:31 volumio sudo[13443]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:31 volumio volumio[12999]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 19 06:31:31 volumio sudo[13450]: pam_unix(sudo:session): session closed for user root
Apr 19 06:31:31 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 19 06:31:31 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -111
Apr 19 06:31:31 volumio volumio[12999]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 19 06:32:05 volumio volumio[12999]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object]
Apr 19 06:32:05 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts
Apr 19 06:32:05 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions
Apr 19 06:32:05 volumio sudo[13584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 19 06:32:05 volumio sudo[13584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:32:05 volumio sudo[13584]: pam_unix(sudo:session): session closed for user root
Apr 19 06:32:05 volumio sudo[13587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 19 06:32:05 volumio sudo[13587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:32:05 volumio volumio[12999]: info: MPD Permissions set
Apr 19 06:32:05 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 06:32:05 volumio systemd[1]: Stopping Music Player Daemon...
Apr 19 06:32:05 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 06:32:05 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 19 06:32:05 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 06:32:05 volumio systemd[1]: mpd.service: Succeeded.
Apr 19 06:32:05 volumio systemd[1]: Stopped Music Player Daemon.
Apr 19 06:32:05 volumio systemd[1]: Starting Music Player Daemon...
Apr 19 06:32:06 volumio sudo[13595]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 19 06:32:06 volumio sudo[13595]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 06:32:06 volumio sudo[13595]: pam_unix(sudo:session): session closed for user root
Apr 19 06:32:06 volumio mpd[13597]: Apr 19 06:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 19 06:32:07 volumio systemd[1]: Started Music Player Daemon.
Apr 19 06:32:07 volumio sudo[13587]: pam_unix(sudo:session): session closed for user root
Apr 19 06:32:07 volumio volumio[12999]: error: updateQueue error: null
Apr 19 06:32:13 volumio volumio[12999]: info: CoreCommandRouter::volumioPause
Apr 19 06:32:13 volumio volumio[12999]: info: CoreStateMachine::pause
Apr 19 06:32:13 volumio volumio[12999]: info: CoreStateMachine::stPlaybackTimer
Apr 19 06:32:13 volumio volumio[12999]: info: CoreStateMachine::servicePause
Apr 19 06:32:13 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:32:13 volumio volumio[12999]: info: CoreCommandRouter::servicePause
Apr 19 06:32:13 volumio volumio[12999]: info: ControllerMpd::pause
Apr 19 06:32:13 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand pause
Apr 19 06:32:13 volumio volumio[12999]: info: sendMpdCommand pause took 1 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::volumioNext
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::next
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::stop
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::updateTrackBlock
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrackBlock
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::stPlaybackTimer
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::serviceStop
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 197
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::serviceStop
Apr 19 06:32:14 volumio volumio[12999]: info: ControllerMpd::stop
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand stop took 3 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::play index undefined
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 128
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::startPlaybackTimer
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 128
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::clearAddPlayTracks NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD07/007.Paolo Meneguzzi - Musica.flac
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand stop
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::updateTrackBlock
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrackBlock
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand stop took 0 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand clear
Apr 19 06:32:14 volumio volumio[12999]: info:
Apr 19 06:32:14 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:32:14 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand clear took 1 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand add "NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD07/007.Paolo Meneguzzi - Musica.flac"
Apr 19 06:32:14 volumio volumio[12999]: error: updateQueue error: null
Apr 19 06:32:14 volumio volumio[12999]: info:
Apr 19 06:32:14 volumio volumio[12999]: ---------------------------- MPD announces system playlist update
Apr 19 06:32:14 volumio volumio[12999]: info: Ignoring MPD Status Update
Apr 19 06:32:14 volumio volumio[12999]: info: ------------------------------ 4ms
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand add "NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD07/007.Paolo Meneguzzi - Musica.flac" took 3 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand play
Apr 19 06:32:14 volumio volumio[12999]: info: ------------------------------ 2ms
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand play took 1 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: info:
Apr 19 06:32:14 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:32:14 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:32:14 volumio volumio[12999]: info:
Apr 19 06:32:14 volumio volumio[12999]: ---------------------------- MPD announces state update: player
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand status took 145 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: info: ControllerMpd::getState
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand status
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand status took 0 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::parseState
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:32:14 volumio volumio[12999]: verbose: ControllerMpd::parseTrackInfo
Apr 19 06:32:14 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 128
Apr 19 06:32:14 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"602 Kbps","isStreaming":false,"title":"Musica","artist":"Paolo Meneguzzi","album":"Musica","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD07/007.Paolo Meneguzzi - Musica.flac","trackType":"flac"}
Apr 19 06:32:14 volumio volumio[12999]: verbose: CURRENT POSITION 128
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus stop
Apr 19 06:32:14 volumio volumio[12999]: info: ControllerMpd::pushState
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::servicePushState
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 128
Apr 19 06:32:14 volumio volumio[12999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"671 Kbps","isStreaming":false,"title":"Musica","artist":"Paolo Meneguzzi","album":"Musica","uri":"NAS/音ä¹/åˆé›†å•ç¢Ÿå•æ›²/世界上最动å¬çš„音ä¹/CD07/007.Paolo Meneguzzi - Musica.flac","trackType":"flac"}
Apr 19 06:32:14 volumio volumio[12999]: verbose: CURRENT POSITION 128
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::syncState stateService play
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::syncState currentStatus play
Apr 19 06:32:14 volumio volumio[12999]: info: Received an update from plugin. extracting info from payload
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 128
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:32:14 volumio volumio[12999]: info: CoreStateMachine::pushState
Apr 19 06:32:14 volumio volumio[12999]: info: CorePlayQueue::getTrack 128
Apr 19 06:32:14 volumio volumio[12999]: info: CoreCommandRouter::volumioPushState
Apr 19 06:32:14 volumio volumio[12999]: info: ------------------------------ 154ms
Apr 19 06:32:14 volumio volumio[12999]: info: ------------------------------ 21ms
Apr 19 06:32:57 volumio volumio[12999]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 19 06:32:57 volumio volumio[12999]: Error: connect ETIMEDOUT 199.59.148.15:80
Apr 19 06:32:57 volumio volumio[12999]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Apr 19 06:32:57 volumio volumio[12999]: errno: -110,
Apr 19 06:32:57 volumio volumio[12999]: code: 'ETIMEDOUT',
Apr 19 06:32:57 volumio volumio[12999]: syscall: 'connect',
Apr 19 06:32:57 volumio volumio[12999]: address: '199.59.148.15',
Apr 19 06:32:57 volumio volumio[12999]: port: 80
Apr 19 06:32:57 volumio volumio[12999]: }
Apr 19 06:32:57 volumio volumio[12999]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 19 06:32:58 volumio sudo[13741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-19 06:31
Apr 19 06:32:58 volumio sudo[13741]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST"
VOLUMIO_VERSION="3.799"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"