-- Logs begin at Wed 2022-07-13 14:55:24 UTC, end at Tue 2025-12-23 06:49:59 UTC. --
Dec 23 06:48:26 musical-fidelity systemd[1]: Starting Cleanup of Temporary Directories...
Dec 23 06:48:26 musical-fidelity volumio[7436]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Dec 23 06:48:26 musical-fidelity systemd[1]: Started Cleanup of Temporary Directories.
Dec 23 06:48:26 musical-fidelity volumio[7436]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function
Dec 23 06:48:26 musical-fidelity volumio[7436]: Error in parsing play status: TypeError: Cannot read property '0' of undefined
Dec 23 06:48:34 musical-fidelity hostapd[1088]: wlan0: STA c2:9c:6e:85:b3:2c IEEE 802.11: associated
Dec 23 06:48:34 musical-fidelity hostapd[1088]: wlan0: STA c2:9c:6e:85:b3:2c RADIUS: starting accounting session 62CEDCEF-00000000
Dec 23 06:48:35 musical-fidelity dhcpd[1062]: DHCPDISCOVER from c2:9c:6e:85:b3:2c via wlan0
Dec 23 06:48:36 musical-fidelity dhcpd[1062]: DHCPOFFER on 192.168.211.33 to c2:9c:6e:85:b3:2c (CET-AL00) via wlan0
Dec 23 06:48:36 musical-fidelity dhcpd[1062]: Wrote 99 leases to leases file.
Dec 23 06:48:36 musical-fidelity dhcpd[1062]: DHCPREQUEST for 192.168.211.33 (192.168.211.1) from c2:9c:6e:85:b3:2c (CET-AL00) via wlan0
Dec 23 06:48:36 musical-fidelity dhcpd[1062]: DHCPACK on 192.168.211.33 to c2:9c:6e:85:b3:2c (CET-AL00) via wlan0
Dec 23 06:48:36 musical-fidelity kernel: RTL871X: ap recv deauth reason code(3) sta:c2:9c:6e:85:b3:2c
Dec 23 06:48:36 musical-fidelity hostapd[1088]: wlan0: STA c2:9c:6e:85:b3:2c IEEE 802.11: disassociated
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Clearing queue after UPNP request
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::ClearQueue
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::stop
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 23 06:48:38 musical-fidelity volumio[7436]: verbose: UNSET VOLATILE
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::stPlaybackTimer
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::updateTrackBlock
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrackBlock
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::serviceStop
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: ControllerMpd::stop
Dec 23 06:48:38 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand stop
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::clearPlayQueue
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::saveQueue
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushQueue
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:38 musical-fidelity volumio[7436]: info:
Dec 23 06:48:38 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:38 musical-fidelity volumio[7436]: info:
Dec 23 06:48:38 musical-fidelity volumio[7436]: ---------------------------- MPD announces state update: player
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: ControllerMpd::getState
Dec 23 06:48:38 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand status
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: sendMpdCommand stop took 114 milliseconds
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Starting UPNP Playback
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Preparing playback through UPNP
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioGetState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 23 06:48:38 musical-fidelity volumio[7436]: error: updateQueue error: null
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: ------------------------------ 13ms
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: sendMpdCommand status took 12 milliseconds
Dec 23 06:48:38 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: ControllerMpd::pushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::servicePushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:48:38 musical-fidelity volumio[7436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 23 06:48:38 musical-fidelity volumio[7436]: verbose: CURRENT POSITION 0
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState stateService stop
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState currentStatus stop
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: No code
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: ------------------------------ 38ms
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:38 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:39 musical-fidelity volumio[7436]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E4%BD%B3/%E5%8F%88%E8%A7%81%E9%82%93%E4%B8%BD%E5%90%9B/d302659a-1ec1-4e82-8969-755911f97b45.jpg'
Dec 23 06:48:39 musical-fidelity volumio[7436]: info:
Dec 23 06:48:39 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: ------------------------------ 4ms
Dec 23 06:48:39 musical-fidelity volumio[7436]: info:
Dec 23 06:48:39 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: ------------------------------ 3ms
Dec 23 06:48:39 musical-fidelity volumio[7436]: info:
Dec 23 06:48:39 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: ------------------------------ 3ms
Dec 23 06:48:39 musical-fidelity volumio[7436]: info:
Dec 23 06:48:39 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info:
Dec 23 06:48:39 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: ------------------------------ 4ms
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: ------------------------------ 3ms
Dec 23 06:48:39 musical-fidelity volumio[7436]: info:
Dec 23 06:48:39 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:48:39 musical-fidelity volumio[7436]: info: ------------------------------ 3ms
Dec 23 06:48:41 musical-fidelity volumio[7436]: info:
Dec 23 06:48:41 musical-fidelity volumio[7436]: ---------------------------- MPD announces state update: player
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: ControllerMpd::getState
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand status
Dec 23 06:48:41 musical-fidelity volumio[7436]: info:
Dec 23 06:48:41 musical-fidelity volumio[7436]: ---------------------------- MPD announces state update: player
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: sendMpdCommand status took 4 milliseconds
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: ControllerMpd::getState
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand status
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseState
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: sendMpdCommand status took 3 milliseconds
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseState
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseTrackInfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: ControllerMpd::pushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::servicePushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: In UPNP mode
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"玻璃窗的爱","artist":"童丽","album":"胆色2","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=8546148&eid=356867918&fmt=6&profile=raw&app_id=195822208&cid=3599692&etsp=1766476118&hmac=MZYFSZdJUiqL0Bdl3CCb_HWpwl8","trackType":"qobuz"}
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: CURRENT POSITION 0
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState stateService play
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState currentStatus stop
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: ------------------------------ 25ms
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: sendMpdCommand playlistinfo took 16 milliseconds
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseTrackInfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: ControllerMpd::pushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::servicePushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: In UPNP mode
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"玻璃窗的爱","artist":"童丽","album":"胆色2","uri":"http://streaming-qobuz-std.akamaized.net/file?uid=8546148&eid=356867918&fmt=6&profile=raw&app_id=195822208&cid=3599692&etsp=1766476118&hmac=MZYFSZdJUiqL0Bdl3CCb_HWpwl8","trackType":"qobuz"}
Dec 23 06:48:41 musical-fidelity volumio[7436]: verbose: CURRENT POSITION 0
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState stateService play
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState currentStatus play
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: Received an update from plugin. extracting info from payload
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: ------------------------------ 48ms
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:48:41 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Clearing queue after UPNP request
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::ClearQueue
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::stop
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 23 06:49:29 musical-fidelity volumio[7436]: verbose: UNSET VOLATILE
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::stPlaybackTimer
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::updateTrackBlock
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrackBlock
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::serviceStop
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: ControllerMpd::stop
Dec 23 06:49:29 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand stop
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::clearPlayQueue
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::saveQueue
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushQueue
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:29 musical-fidelity volumio[7436]: info:
Dec 23 06:49:29 musical-fidelity volumio[7436]: ---------------------------- MPD announces state update: player
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: sendMpdCommand stop took 111 milliseconds
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: ControllerMpd::getState
Dec 23 06:49:29 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand status
Dec 23 06:49:29 musical-fidelity volumio[7436]: info:
Dec 23 06:49:29 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: sendMpdCommand status took 2 milliseconds
Dec 23 06:49:29 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: ControllerMpd::pushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::servicePushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 23 06:49:29 musical-fidelity volumio[7436]: verbose: CURRENT POSITION 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState stateService stop
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState currentStatus stop
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: No code
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: ------------------------------ 31ms
Dec 23 06:49:29 musical-fidelity volumio[7436]: error: updateQueue error: null
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: ------------------------------ 31ms
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Starting UPNP Playback
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: Preparing playback through UPNP
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioGetState
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CorePlayQueue::getTrack 0
Dec 23 06:49:29 musical-fidelity volumio[7436]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 2ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 6ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 4ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 5ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 3ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces system playlist update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Ignoring MPD Status Update
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 2ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces state update: player
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ControllerMpd::getState
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand status
Dec 23 06:49:30 musical-fidelity volumio[7436]: info:
Dec 23 06:49:30 musical-fidelity volumio[7436]: ---------------------------- MPD announces state update: player
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: sendMpdCommand status took 3 milliseconds
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ControllerMpd::getState
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand status
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseState
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: sendMpdCommand status took 4 milliseconds
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseState
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseTrackInfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ControllerMpd::pushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::servicePushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: In UPNP mode
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"恰似你的温柔","artist":"陈佳","album":"又见邓丽君","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidjYzA3OGZiZDFjNzNlNDkyYWYyZjFlMTgxOTZjYzE2MF82MS5tcDQ/0.flac?token=1766476168~MmZkODQxMWUyNWJhMDY2NWU0Nzk3ZTAyOTY5ZjE1YWZiOTMwMWI1ZQ==","trackType":"tidal"}
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: CURRENT POSITION 0
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState stateService play
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState currentStatus stop
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 31ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: sendMpdCommand playlistinfo took 20 milliseconds
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: ControllerMpd::parseTrackInfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ControllerMpd::pushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::servicePushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: In UPNP mode
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"208 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"陈佳","album":"又见邓丽君","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidjYzA3OGZiZDFjNzNlNDkyYWYyZjFlMTgxOTZjYzE2MF82MS5tcDQ/0.flac?token=1766476168~MmZkODQxMWUyNWJhMDY2NWU0Nzk3ZTAyOTY5ZjE1YWZiOTMwMWI1ZQ==","trackType":"tidal"}
Dec 23 06:49:30 musical-fidelity volumio[7436]: verbose: CURRENT POSITION 0
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState stateService play
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::syncState currentStatus play
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Received an update from plugin. extracting info from payload
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreStateMachine::pushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::volumioPushState
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: ------------------------------ 61ms
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:30 musical-fidelity volumio[7436]: info: Updating RAAT Signal Path
Dec 23 06:49:58 musical-fidelity volumio[7436]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 23 06:49:58 musical-fidelity volumio[7436]: { Error: connect ETIMEDOUT 157.240.3.8:443
Dec 23 06:49:58 musical-fidelity volumio[7436]: at Object._errnoException (util.js:1022:11)
Dec 23 06:49:58 musical-fidelity volumio[7436]: at _exceptionWithHostPort (util.js:1044:20)
Dec 23 06:49:58 musical-fidelity volumio[7436]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Dec 23 06:49:58 musical-fidelity volumio[7436]: code: 'ETIMEDOUT',
Dec 23 06:49:58 musical-fidelity volumio[7436]: errno: 'ETIMEDOUT',
Dec 23 06:49:58 musical-fidelity volumio[7436]: syscall: 'connect',
Dec 23 06:49:58 musical-fidelity volumio[7436]: address: '157.240.3.8',
Dec 23 06:49:58 musical-fidelity volumio[7436]: port: 443 }
Dec 23 06:49:58 musical-fidelity volumio[7436]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 23 06:49:59 musical-fidelity sudo[9274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-23 06:48
Dec 23 06:49:59 musical-fidelity sudo[9274]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="mf"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022"
VOLUMIO_VERSION="1.079"
VOLUMIO_HARDWARE="pi"
VOLUMIO_VENDOR="Musical Fidelity"
VOLUMIO_MODEL="MX-Stream"
VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream"
VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"