Dec 19 13:31:06 odroid systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 19 13:31:07 odroid systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 19 13:31:07 odroid systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 19 13:31:18 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:31:18 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:31:18 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:31:18 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:31:18 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:31:18 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:31:49 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:31:49 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:31:49 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:31:49 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:31:49 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:31:49 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:32:02 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:02 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:02 odroid volumio[1161]: info: Prefetching next song Dec 19 13:32:02 odroid volumio[1161]: info: DOING PREFETCH IN MPD Dec 19 13:32:02 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac" Dec 19 13:32:02 odroid volumio[1161]: info: Dec 19 13:32:02 odroid volumio[1161]: ---------------------------- MPD announces system playlist update Dec 19 13:32:02 odroid volumio[1161]: info: Ignoring MPD Status Update Dec 19 13:32:02 odroid volumio[1161]: info: sendMpdCommand add "INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac" took 1 milliseconds Dec 19 13:32:02 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand consume 1 Dec 19 13:32:02 odroid volumio[1161]: info: Dec 19 13:32:02 odroid volumio[1161]: ---------------------------- MPD announces system playlist update Dec 19 13:32:02 odroid volumio[1161]: info: Ignoring MPD Status Update Dec 19 13:32:02 odroid volumio[1161]: info: Dec 19 13:32:02 odroid volumio[1161]: ---------------------------- MPD announces system playlist update Dec 19 13:32:02 odroid volumio[1161]: info: Ignoring MPD Status Update Dec 19 13:32:02 odroid volumio[1161]: info: ------------------------------ 1ms Dec 19 13:32:02 odroid volumio[1161]: info: sendMpdCommand consume 1 took 1 milliseconds Dec 19 13:32:02 odroid volumio[1161]: info: ------------------------------ 1ms Dec 19 13:32:02 odroid volumio[1161]: info: ------------------------------ 0ms Dec 19 13:32:06 odroid volumio[1161]: info: Dec 19 13:32:06 odroid volumio[1161]: ---------------------------- MPD announces system playlist update Dec 19 13:32:06 odroid volumio[1161]: info: Ignoring MPD Status Update Dec 19 13:32:06 odroid volumio[1161]: info: Dec 19 13:32:06 odroid volumio[1161]: ---------------------------- MPD announces state update: player Dec 19 13:32:06 odroid volumio[1161]: info: ControllerMpd::getState Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:32:06 odroid volumio[1161]: info: Dec 19 13:32:06 odroid volumio[1161]: ---------------------------- MPD announces system playlist update Dec 19 13:32:06 odroid volumio[1161]: info: Ignoring MPD Status Update Dec 19 13:32:06 odroid volumio[1161]: info: Dec 19 13:32:06 odroid volumio[1161]: ---------------------------- MPD announces state update: player Dec 19 13:32:06 odroid volumio[1161]: info: ControllerMpd::getState Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:32:06 odroid volumio[1161]: info: Dec 19 13:32:06 odroid volumio[1161]: ---------------------------- MPD announces system playlist update Dec 19 13:32:06 odroid volumio[1161]: info: Ignoring MPD Status Update Dec 19 13:32:06 odroid volumio[1161]: info: Dec 19 13:32:06 odroid volumio[1161]: ---------------------------- MPD announces state update: player Dec 19 13:32:06 odroid volumio[1161]: info: ControllerMpd::getState Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:32:06 odroid volumio[1161]: info: ------------------------------ 2ms Dec 19 13:32:06 odroid volumio[1161]: info: sendMpdCommand status took 1 milliseconds Dec 19 13:32:06 odroid volumio[1161]: info: ------------------------------ 1ms Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::parseState Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:32:06 odroid volumio[1161]: info: sendMpdCommand status took 2 milliseconds Dec 19 13:32:06 odroid volumio[1161]: info: ------------------------------ 1ms Dec 19 13:32:06 odroid volumio[1161]: info: sendMpdCommand status took 1 milliseconds Dec 19 13:32:06 odroid volumio[1161]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::parseState Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::parseState Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:32:06 odroid volumio[1161]: info: ControllerMpd::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::servicePushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Crawling Up a Hill","artist":"Katie Melua","album":"Call off the Search [Enhanced]","uri":"INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac","trackType":"flac"} Dec 19 13:32:06 odroid volumio[1161]: verbose: CURRENT POSITION 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::syncState stateService play Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::syncState currentStatus play Dec 19 13:32:06 odroid volumio[1161]: info: Received an update from plugin. extracting info from payload Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:06 odroid volumio[1161]: info: ------------------------------ 7ms Dec 19 13:32:06 odroid volumio[1161]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 19 13:32:06 odroid volumio[1161]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:32:06 odroid volumio[1161]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:32:06 odroid volumio[1161]: info: ControllerMpd::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::servicePushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Crawling Up a Hill","artist":"Katie Melua","album":"Call off the Search [Enhanced]","uri":"INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac","trackType":"flac"} Dec 19 13:32:06 odroid volumio[1161]: verbose: CURRENT POSITION 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::syncState stateService play Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::syncState currentStatus play Dec 19 13:32:06 odroid volumio[1161]: info: Received an update from plugin. extracting info from payload Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:06 odroid volumio[1161]: info: ControllerMpd::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::servicePushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Crawling Up a Hill","artist":"Katie Melua","album":"Call off the Search [Enhanced]","uri":"INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac","trackType":"flac"} Dec 19 13:32:06 odroid volumio[1161]: verbose: CURRENT POSITION 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::syncState stateService play Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::syncState currentStatus play Dec 19 13:32:06 odroid volumio[1161]: info: Received an update from plugin. extracting info from payload Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 0 Dec 19 13:32:06 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:06 odroid volumio[1161]: info: ------------------------------ 13ms Dec 19 13:32:06 odroid volumio[1161]: info: ------------------------------ 12ms Dec 19 13:32:06 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:06 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:06 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:06 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:06 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:06 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:06 odroid volumio[1161]: info: CoreStateMachine::startPlaybackTimer Dec 19 13:32:06 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:07 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:07 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:07 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 13:32:07 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:07 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:18 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:32:18 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:32:18 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:32:18 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:18 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:18 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:32:33 odroid sudo[48136]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 13:32:33 odroid sudo[48136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:32:33 odroid sudo[48138]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:32:33 odroid sudo[48138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:32:33 odroid sudo[48136]: pam_unix(sudo:session): session closed for user root Dec 19 13:32:33 odroid sudo[48138]: pam_unix(sudo:session): session closed for user root Dec 19 13:32:33 odroid volumio[1161]: verbose: New Socket.io Connection to 10.0.0.17 from 10.0.0.22 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 19 13:32:34 odroid sudo[48151]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 13:32:34 odroid sudo[48151]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:32:34 odroid sudo[48151]: pam_unix(sudo:session): session closed for user root Dec 19 13:32:34 odroid sudo[48153]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:32:34 odroid sudo[48153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:32:34 odroid sudo[48153]: pam_unix(sudo:session): session closed for user root Dec 19 13:32:35 odroid volumio[1161]: verbose: New Socket.io Connection to 10.0.0.17 from 10.0.0.22 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 19 13:32:35 odroid sudo[48159]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 13:32:35 odroid sudo[48159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:32:35 odroid sudo[48161]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 13:32:35 odroid sudo[48161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 13:32:35 odroid sudo[48159]: pam_unix(sudo:session): session closed for user root Dec 19 13:32:35 odroid sudo[48161]: pam_unix(sudo:session): session closed for user root Dec 19 13:32:35 odroid volumio[1161]: verbose: New Socket.io Connection to 10.0.0.17 from 10.0.0.22 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::volumioGetVisibleSources Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:35 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 19 13:32:35 odroid volumio[1161]: info: Received Get System Info Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:32:35 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:35 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:35 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:35 odroid volumio[1161]: info: Listing playlists Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 19 13:32:35 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 19 13:32:36 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:36 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:36 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 19 13:32:37 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 19 13:32:37 odroid volumio[1161]: info: Received Get System Info Dec 19 13:32:37 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:32:37 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:32:37 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:32:37 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:37 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:37 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:32:38 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 19 13:32:38 odroid volumio[1161]: info: Received Get System Info Dec 19 13:32:38 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:32:38 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:32:38 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:32:38 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:38 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:38 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::volumioPause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::stPlaybackTimer Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::servicePause Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::servicePause Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::pause Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand pause Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand pause took 1 milliseconds Dec 19 13:32:41 odroid volumio[1161]: info: Dec 19 13:32:41 odroid volumio[1161]: ---------------------------- MPD announces state update: player Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::getState Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:32:41 odroid volumio[1161]: info: Dec 19 13:32:41 odroid volumio[1161]: ---------------------------- MPD announces state update: player Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::getState Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:32:41 odroid volumio[1161]: info: Dec 19 13:32:41 odroid volumio[1161]: ---------------------------- MPD announces state update: player Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::getState Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand status took 1 milliseconds Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand status took 1 milliseconds Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::parseState Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::parseState Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand status took 1 milliseconds Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::parseState Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::pushState Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::servicePushState Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":35654,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"935 Kbps","isStreaming":false,"title":"Crawling Up a Hill","artist":"Katie Melua","album":"Call off the Search [Enhanced]","uri":"INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac","trackType":"flac"} Dec 19 13:32:41 odroid volumio[1161]: verbose: CURRENT POSITION 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::syncState stateService pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::syncState currentStatus pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::stPlaybackTimer Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::pushState Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::servicePushState Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":35654,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"935 Kbps","isStreaming":false,"title":"Crawling Up a Hill","artist":"Katie Melua","album":"Call off the Search [Enhanced]","uri":"INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac","trackType":"flac"} Dec 19 13:32:41 odroid volumio[1161]: verbose: CURRENT POSITION 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::syncState stateService pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::syncState currentStatus pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::stPlaybackTimer Dec 19 13:32:41 odroid volumio[1161]: info: ------------------------------ 7ms Dec 19 13:32:41 odroid volumio[1161]: info: ------------------------------ 7ms Dec 19 13:32:41 odroid volumio[1161]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 19 13:32:41 odroid volumio[1161]: verbose: ControllerMpd::parseTrackInfo Dec 19 13:32:41 odroid volumio[1161]: info: ControllerMpd::pushState Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::servicePushState Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":35654,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"935 Kbps","isStreaming":false,"title":"Crawling Up a Hill","artist":"Katie Melua","album":"Call off the Search [Enhanced]","uri":"INTERNAL/SSD/Music/Katie Melua/Call Off the Search/02 - Crawling Up a Hill.flac","trackType":"flac"} Dec 19 13:32:41 odroid volumio[1161]: verbose: CURRENT POSITION 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::syncState stateService pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::syncState currentStatus pause Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::pushState Dec 19 13:32:41 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:41 odroid volumio[1161]: info: CoreCommandRouter::volumioPushState Dec 19 13:32:41 odroid volumio[1161]: info: CoreStateMachine::stPlaybackTimer Dec 19 13:32:41 odroid volumio[1161]: info: ------------------------------ 10ms Dec 19 13:32:41 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:41 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:41 odroid volumio[1161]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 19 13:32:42 odroid aoe[986]: 011539.446 unbox [ 291] 184| recv *Data Request*, but there are 0B left (11:Resource temporarily unavailable), send *Close* Dec 19 13:32:43 odroid volumio[1161]: info: CoreCommandRouter::volumioGetQueue Dec 19 13:32:43 odroid volumio[1161]: info: CoreStateMachine::getQueue Dec 19 13:32:43 odroid volumio[1161]: info: CorePlayQueue::getQueue Dec 19 13:32:45 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 19 13:32:48 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 19 13:32:48 odroid volumio[1161]: info: Preload queue cleared Dec 19 13:32:48 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 19 13:32:48 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 19 13:32:48 odroid volumio[1161]: info: Discovery: Getting this device information Dec 19 13:32:48 odroid volumio[1161]: info: CoreCommandRouter::volumioGetState Dec 19 13:32:48 odroid volumio[1161]: info: CorePlayQueue::getTrack 1 Dec 19 13:32:48 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 19 13:32:53 odroid volumio[1161]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Dec 19 13:32:53 odroid volumio[1161]: info: Preload queue cleared Dec 19 13:32:53 odroid volumio[1161]: info: Preloading song: webkbs/0 Dec 19 13:32:53 odroid volumio[1161]: info: Preloading song: webkbs/1 Dec 19 13:32:53 odroid volumio[1161]: info: Preloading song: webkbs/2 Dec 19 13:32:53 odroid volumio[1161]: info: Preloading song: webkbs/3 Dec 19 13:32:53 odroid volumio[1161]: info: Preloading song: webkbs/4 Dec 19 13:32:53 odroid volumio[1161]: info: Preloading song: webkbs/5 Dec 19 13:32:53 odroid volumio[1161]: info: Exploding uri webkbs/0 in service personal_radio Dec 19 13:32:53 odroid volumio[1161]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 13:32:53 odroid volumio[1161]: TypeError [ERR_INVALID_ARG_TYPE]: The "url" argument must be of type string. Received undefined Dec 19 13:32:53 odroid volumio[1161]: at new NodeError (node:internal/errors:405:5) Dec 19 13:32:53 odroid volumio[1161]: at validateString (node:internal/validators:162:11) Dec 19 13:32:53 odroid volumio[1161]: at Url.parse (node:url:170:3) Dec 19 13:32:53 odroid volumio[1161]: at Object.urlParse [as parse] (node:url:141:13) Dec 19 13:32:53 odroid volumio[1161]: at /data/plugins/music_service/personal_radio/index.js:675:19 Dec 19 13:32:53 odroid volumio[1161]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Dec 19 13:32:53 odroid volumio[1161]: code: 'ERR_INVALID_ARG_TYPE' Dec 19 13:32:53 odroid volumio[1161]: } Dec 19 13:32:53 odroid volumio[1161]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 13:32:53 odroid sudo[48252]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-19 13:31' Dec 19 13:32:53 odroid sudo[48252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"