-- Logs begin at Wed 2025-12-10 22:22:44 CST, end at Wed 2025-12-10 22:50:06 CST. -- Dec 10 22:49:05 volumio volumio[6543]: info: Preload queue cleared Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::ClearQueue Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::serviceStop Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::serviceStop Dec 10 22:49:05 volumio volumio[6543]: info: Airplay Stop Dec 10 22:49:05 volumio volumio[6543]: info: Stopping Airplay Playback and sending pause command to client via USR2 Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::clearPlayQueue Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::saveQueue Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushQueue Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::addQueueItems Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::addQueueItems Dec 10 22:49:05 volumio volumio[6543]: info: Preload queue cleared Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/01. 习惯寂寞.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/01. 习惯寂寞.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/02. 黄玫瑰.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/02. 黄玫瑰.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushQueue Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::saveQueue Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::updateTrackBlock Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrackBlock Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPlay Dec 10 22:49:05 volumio volumio[6543]: verbose: UNSET VOLATILE: Service: airplay_emulation Dec 10 22:49:05 volumio volumio[6543]: info: Stopping Airplay Playback and sending pause command to client via USR2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::play index 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::addQueueItems Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::addQueueItems Dec 10 22:49:05 volumio volumio[6543]: info: Preload queue cleared Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/04. 分手.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/04. 分手.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/05. 女人泪.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/05. 女人泪.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/06. 烟雨蒙蒙.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/06. 烟雨蒙蒙.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/07. 悲伤的眼泪逆流成河.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/07. 悲伤的眼泪逆流成河.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/08. 月满西楼.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/08. 月满西楼.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/09. 猜心.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/09. 猜心.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/10. 错过.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/10. 错过.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/11. 爱无伤伤无悔.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/11. 爱无伤伤无悔.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/12. 爱情的秋天.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/12. 爱情的秋天.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/13. 无情的坏男人.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/13. 无情的坏男人.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/14. 离别的秋天.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/14. 离别的秋天.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/15. 无法原谅.wav Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/15. 无法原谅.wav Dec 10 22:49:05 volumio volumio[6543]: info: Adding Item to queue: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/未知艺术家 - 试音孙露 DXD.m3u Dec 10 22:49:05 volumio volumio[6543]: info: Using cached record of: music-library/INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/未知艺术家 - 试音孙露 DXD.m3u Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::stPlaybackTimer Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::updateTrackBlock Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrackBlock Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 0 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:05 volumio sudo[8747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 6838 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio sudo[8747]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::serviceStop Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 0 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::serviceStop Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::stop Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushQueue Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::saveQueue Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::updateTrackBlock Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrackBlock Dec 10 22:49:05 volumio sudo[8749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 6838 Dec 10 22:49:05 volumio sudo[8749]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 22:49:05 volumio sudo[8749]: pam_unix(sudo:session): session closed for user root Dec 10 22:49:05 volumio sudo[8747]: pam_unix(sudo:session): session closed for user root Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand stop took 68 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::play index undefined Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::startPlaybackTimer Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 22:49:05 volumio volumio[6543]: info: Shairport-Sync paused with USR2 Dec 10 22:49:05 volumio volumio[6543]: info: Shairport-Sync paused with USR2 Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand stop took 9 milliseconds Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces system playlist update Dec 10 22:49:05 volumio volumio[6543]: info: Ignoring MPD Status Update Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand clear took 8 milliseconds Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav" Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces system playlist update Dec 10 22:49:05 volumio volumio[6543]: info: Ignoring MPD Status Update Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces system playlist update Dec 10 22:49:05 volumio volumio[6543]: info: Ignoring MPD Status Update Dec 10 22:49:05 volumio volumio[6543]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. Dec 10 22:49:05 volumio volumio[6543]: error: updateQueue error: null Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces system playlist update Dec 10 22:49:05 volumio volumio[6543]: info: Ignoring MPD Status Update Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 15ms Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand add "INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav" took 13 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 11ms Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 9ms Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand play Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces system playlist update Dec 10 22:49:05 volumio volumio[6543]: info: Ignoring MPD Status Update Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces system playlist update Dec 10 22:49:05 volumio volumio[6543]: info: Ignoring MPD Status Update Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 13ms Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand play took 9 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 10ms Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 8ms Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand status took 22 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand status took 20 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand status took 17 milliseconds Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:05 volumio volumio[6543]: info: Dec 10 22:49:05 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand status took 16 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 12 milliseconds Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:05 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState stateService play Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus stop Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:05 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState stateService play Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus play Dec 10 22:49:05 volumio volumio[6543]: info: Received an update from plugin. extracting info from payload Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:05 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState stateService play Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus play Dec 10 22:49:05 volumio volumio[6543]: info: Received an update from plugin. extracting info from payload Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 74ms Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 166ms Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 163ms Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand status took 141 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand status took 138 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 130 milliseconds Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:05 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState stateService play Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus play Dec 10 22:49:05 volumio volumio[6543]: info: Received an update from plugin. extracting info from payload Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 169ms Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 90 milliseconds Dec 10 22:49:05 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 89 milliseconds Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:05 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:05 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState stateService play Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus play Dec 10 22:49:05 volumio volumio[6543]: info: Received an update from plugin. extracting info from payload Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:05 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState stateService play Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus play Dec 10 22:49:05 volumio volumio[6543]: info: Received an update from plugin. extracting info from payload Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:05 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:05 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 274ms Dec 10 22:49:05 volumio volumio[6543]: info: ------------------------------ 273ms Dec 10 22:49:06 volumio volumio[6543]: info: Restarting Shairport-Sync after stop Dec 10 22:49:06 volumio volumio[6543]: info: Restarting Shairport-Sync after stop Dec 10 22:49:06 volumio sudo[8757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 10 22:49:06 volumio sudo[8757]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 22:49:06 volumio sudo[8759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 10 22:49:06 volumio sudo[8759]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 10 22:49:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 10 22:49:06 volumio shairport-sync[6838]: {"time":1765377981253,"response":"startAirplayPlayback Success"} Dec 10 22:49:06 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 10 22:49:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 10 22:49:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 10 22:49:06 volumio sudo[8757]: pam_unix(sudo:session): session closed for user root Dec 10 22:49:06 volumio volumio[6543]: info: Shairport-Sync retarted Dec 10 22:49:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 10 22:49:06 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 10 22:49:06 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 10 22:49:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 10 22:49:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 10 22:49:06 volumio sudo[8759]: pam_unix(sudo:session): session closed for user root Dec 10 22:49:06 volumio volumio[6543]: info: Shairport-Sync retarted Dec 10 22:49:18 volumio volumio[6543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Dec 10 22:49:21 volumio volumio[6543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Dec 10 22:49:21 volumio volumio[6543]: info: CoreCommandRouter::volumioGetState Dec 10 22:49:21 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:35 volumio volumio[6543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Dec 10 22:49:35 volumio volumio[6543]: info: CoreCommandRouter::volumioGetState Dec 10 22:49:35 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: Airplay started streaming, receiving metadatas Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::volumioStop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::stPlaybackTimer Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::updateTrackBlock Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrackBlock Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::serviceStop Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::serviceStop Dec 10 22:49:51 volumio volumio[6543]: info: ControllerMpd::stop Dec 10 22:49:51 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:51 volumio volumio[6543]: info: Airplay started streaming, receiving metadatas Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::volumioStop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:51 volumio volumio[6543]: info: Airplay started streaming, receiving metadatas Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::volumioStop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:51 volumio volumio[6543]: info: Airplay started streaming, receiving metadatas Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::volumioStop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:51 volumio volumio[6543]: info: Updating volume from AirPlay: -20; 33% Dec 10 22:49:51 volumio volumio[6543]: info: VolumeController::SetAlsaVolume33 Dec 10 22:49:51 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:51 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:51 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:51 volumio shairport-sync[8763]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 10 22:49:51 volumio shairport-sync[8763]: Dload Upload Total Spent Left Speed Dec 10 22:49:51 volumio volumio[6543]: info: Dec 10 22:49:51 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:51 volumio volumio[6543]: info: sendMpdCommand stop took 131 milliseconds Dec 10 22:49:51 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:51 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:51 volumio volumio[6543]: info: Dec 10 22:49:51 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:51 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:51 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:51 volumio volumio[6543]: info: Dec 10 22:49:51 volumio volumio[6543]: ---------------------------- MPD announces state update: player Dec 10 22:49:51 volumio volumio[6543]: info: ControllerMpd::getState Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand status Dec 10 22:49:52 volumio volumio[6543]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. Dec 10 22:49:52 volumio volumio[6543]: info: sendMpdCommand status took 25 milliseconds Dec 10 22:49:52 volumio volumio[6543]: info: sendMpdCommand status took 23 milliseconds Dec 10 22:49:52 volumio volumio[6543]: info: sendMpdCommand status took 22 milliseconds Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::parseState Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 22:49:52 volumio volumio[6543]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Dec 10 22:49:52 volumio volumio[6543]: info: Dec 10 22:49:52 volumio volumio[6543]: ---------------------------- Client requests Start Airplay PlaybackRoutine Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Dec 10 22:49:52 volumio volumio[6543]: info: Airplay playback start Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioStop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 22:49:52 volumio shairport-sync[8763]: [158B blob data] Dec 10 22:49:52 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 48 milliseconds Dec 10 22:49:52 volumio volumio[6543]: info: sendMpdCommand playlistinfo took 52 milliseconds Dec 10 22:49:52 volumio volumio[6543]: verbose: ControllerMpd::parseTrackInfo Dec 10 22:49:52 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: 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":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:52 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::syncState stateService stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: No code Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: 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":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:52 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::syncState stateService stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: No code Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: ControllerMpd::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: 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":"03. 别在分手的时候说爱我.wav","artist":null,"album":null,"uri":"INTERNAL/music/HI-FI顶级人声测试天碟《试音孙露 DXD》/03. 别在分手的时候说爱我.wav","trackType":"wav"} Dec 10 22:49:52 volumio volumio[6543]: verbose: CURRENT POSITION 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::syncState stateService stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::syncState currentStatus stop Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: No code Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: ------------------------------ 166ms Dec 10 22:49:52 volumio volumio[6543]: info: ------------------------------ 162ms Dec 10 22:49:52 volumio volumio[6543]: info: ------------------------------ 161ms Dec 10 22:49:52 volumio volumio[6543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioGetState Dec 10 22:49:52 volumio volumio[6543]: info: CorePlayQueue::getTrack 2 Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:52 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:53 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:53 volumio volumio[6543]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sunglasses%20Kid/Internal%20Affairs/1c3ac8e9-5edc-4121-be0f-9eeca3355125.jpg' Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::servicePushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreStateMachine::pushState Dec 10 22:49:59 volumio volumio[6543]: info: CoreCommandRouter::volumioPushState Dec 10 22:50:00 volumio volumio[6543]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Dec 10 22:50:01 volumio volumio[6543]: info: peppy_screensaver: Start PeppyMeter Dec 10 22:50:05 volumio volumio[6543]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 22:50:05 volumio volumio[6543]: Error: connect ETIMEDOUT 103.200.30.143:443 Dec 10 22:50:05 volumio volumio[6543]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Dec 10 22:50:05 volumio volumio[6543]: errno: -110, Dec 10 22:50:05 volumio volumio[6543]: code: 'ETIMEDOUT', Dec 10 22:50:05 volumio volumio[6543]: syscall: 'connect', Dec 10 22:50:05 volumio volumio[6543]: address: '103.200.30.143', Dec 10 22:50:05 volumio volumio[6543]: port: 443 Dec 10 22:50:05 volumio volumio[6543]: } Dec 10 22:50:05 volumio volumio[6543]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 22:50:06 volumio sudo[9106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-10 22:49 Dec 10 22:50:06 volumio sudo[9106]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"