-- Logs begin at Thu 2019-02-14 12:12:00 SAST, end at Sun 2024-07-21 08:05:40 SAST. -- Jul 21 08:04:07 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:04:17 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:04:17 bodgebox volumio[899]: info: Listing playlists Jul 21 08:04:17 bodgebox volumio[899]: info: Listing playlists Jul 21 08:04:27 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:04:37 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:04:37 bodgebox volumio[899]: info: Listing playlists Jul 21 08:04:37 bodgebox volumio[899]: info: Listing playlists Jul 21 08:04:47 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:04:57 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:04:57 bodgebox volumio[899]: info: Listing playlists Jul 21 08:04:57 bodgebox volumio[899]: info: Listing playlists Jul 21 08:05:07 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:05:17 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:05:17 bodgebox volumio[899]: info: Listing playlists Jul 21 08:05:17 bodgebox volumio[899]: info: Listing playlists Jul 21 08:05:19 bodgebox volumio[899]: info: Clearing queue after UPNP request Jul 21 08:05:19 bodgebox volumio[899]: verbose: UNSET VOLATILE: Service: airplay_emulation Jul 21 08:05:19 bodgebox volumio[899]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jul 21 08:05:20 bodgebox sudo[2080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 1092 Jul 21 08:05:20 bodgebox sudo[2080]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 08:05:20 bodgebox sudo[2080]: pam_unix(sudo:session): session closed for user root Jul 21 08:05:20 bodgebox volumio[899]: info: Shairport-Sync paused with USR2 Jul 21 08:05:20 bodgebox volumio[899]: info: CoreStateMachine::ClearQueue Jul 21 08:05:20 bodgebox volumio[899]: info: CoreStateMachine::stop Jul 21 08:05:20 bodgebox volumio[899]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 08:05:20 bodgebox volumio[899]: info: CorePlayQueue::clearPlayQueue Jul 21 08:05:20 bodgebox volumio[899]: info: CorePlayQueue::saveQueue Jul 21 08:05:20 bodgebox volumio[899]: info: CoreCommandRouter::volumioPushState Jul 21 08:05:20 bodgebox volumio[899]: info: CoreCommandRouter::volumioPushQueue Jul 21 08:05:20 bodgebox volumio[899]: error: Upnp client error: Error: This socket has been ended by the other party Jul 21 08:05:21 bodgebox volumio[899]: info: Restarting Shairport-Sync after stop Jul 21 08:05:21 bodgebox nmbd[674]: [2024/07/21 08:05:21.093350, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 21 08:05:21 bodgebox nmbd[674]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.20 for name WORKGROUP<1d>. Jul 21 08:05:21 bodgebox nmbd[674]: This response was from IP 192.168.0.10, reporting an IP address of 192.168.0.10. Jul 21 08:05:21 bodgebox sudo[2084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 21 08:05:21 bodgebox sudo[2084]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 08:05:21 bodgebox systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 21 08:05:21 bodgebox shairport-sync[1092]: {"time":1721541754391,"response":"stopAirplayPlayback Success"} Jul 21 08:05:21 bodgebox systemd[1]: shairport-sync.service: Succeeded. Jul 21 08:05:21 bodgebox systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 21 08:05:21 bodgebox systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 21 08:05:21 bodgebox sudo[2084]: pam_unix(sudo:session): session closed for user root Jul 21 08:05:21 bodgebox volumio[899]: info: Shairport-Sync retarted Jul 21 08:05:21 bodgebox volumio[899]: info: Starting UPNP Playback Jul 21 08:05:21 bodgebox volumio[899]: info: Preparing playback through UPNP Jul 21 08:05:21 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:05:21 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:21 bodgebox volumio[899]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 21ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 15ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 13ms Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 13ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 9ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 6ms Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 11ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 15ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 13ms Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 11ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 7ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 5ms Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 10ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 7ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 5ms Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 9ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 7ms Jul 21 08:05:22 bodgebox volumio[899]: info: ------------------------------ 5ms Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces state update: player Jul 21 08:05:22 bodgebox volumio[899]: info: ControllerMpd::getState Jul 21 08:05:22 bodgebox kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand status Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces state update: player Jul 21 08:05:22 bodgebox volumio[899]: info: ControllerMpd::getState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand status Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces state update: player Jul 21 08:05:22 bodgebox volumio[899]: info: ControllerMpd::getState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand status Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces state update: player Jul 21 08:05:22 bodgebox volumio[899]: info: sendMpdCommand status took 20 milliseconds Jul 21 08:05:22 bodgebox volumio[899]: info: ControllerMpd::getState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand status Jul 21 08:05:22 bodgebox volumio[899]: info: sendMpdCommand status took 17 milliseconds Jul 21 08:05:22 bodgebox volumio[899]: info: sendMpdCommand status took 11 milliseconds Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::parseState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::parseState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::parseState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces state update: player Jul 21 08:05:22 bodgebox volumio[899]: info: ControllerMpd::getState Jul 21 08:05:22 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand status Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces system playlist update Jul 21 08:05:22 bodgebox volumio[899]: info: Ignoring MPD Status Update Jul 21 08:05:22 bodgebox volumio[899]: info: Jul 21 08:05:22 bodgebox volumio[899]: ---------------------------- MPD announces state update: player Jul 21 08:05:22 bodgebox volumio[1105]: 30 Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::getState Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand status Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 44ms Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand status took 37 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand playlistinfo took 32 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 23ms Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand status took 19 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 17ms Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand status took 13 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseState Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseTrackInfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseTrackInfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseTrackInfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseState Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseState Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::servicePushState Jul 21 08:05:23 bodgebox volumio[899]: verbose: In UPNP mode Jul 21 08:05:23 bodgebox volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","artist":"Music Assistant","album":null,"uri":"http://192.168.0.11:8097/single/uuid:27d1bc57-1c71-52eb-9614-c4e984da151c/c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","trackType":""} Jul 21 08:05:23 bodgebox volumio[899]: verbose: CURRENT POSITION 0 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState stateService play Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState currentStatus stop Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::servicePushState Jul 21 08:05:23 bodgebox volumio[899]: verbose: In UPNP mode Jul 21 08:05:23 bodgebox volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":251,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","artist":"Music Assistant","album":null,"uri":"http://192.168.0.11:8097/single/uuid:27d1bc57-1c71-52eb-9614-c4e984da151c/c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","trackType":""} Jul 21 08:05:23 bodgebox volumio[899]: verbose: CURRENT POSITION 0 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState stateService play Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState currentStatus play Jul 21 08:05:23 bodgebox volumio[899]: info: Received an update from plugin. extracting info from payload Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::servicePushState Jul 21 08:05:23 bodgebox volumio[899]: verbose: In UPNP mode Jul 21 08:05:23 bodgebox volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","artist":"Music Assistant","album":null,"uri":"http://192.168.0.11:8097/single/uuid:27d1bc57-1c71-52eb-9614-c4e984da151c/c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","trackType":""} Jul 21 08:05:23 bodgebox volumio[899]: verbose: CURRENT POSITION 0 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState stateService play Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState currentStatus play Jul 21 08:05:23 bodgebox volumio[899]: info: Received an update from plugin. extracting info from payload Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 119ms Jul 21 08:05:23 bodgebox volumio[899]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:23 bodgebox volumio[899]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 111ms Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 107ms Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand playlistinfo took 51 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand playlistinfo took 44 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: info: sendMpdCommand playlistinfo took 42 milliseconds Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseTrackInfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseTrackInfo Jul 21 08:05:23 bodgebox volumio[899]: verbose: ControllerMpd::parseTrackInfo Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::servicePushState Jul 21 08:05:23 bodgebox volumio[899]: verbose: In UPNP mode Jul 21 08:05:23 bodgebox volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","artist":"Music Assistant","album":null,"uri":"http://192.168.0.11:8097/single/uuid:27d1bc57-1c71-52eb-9614-c4e984da151c/c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","trackType":""} Jul 21 08:05:23 bodgebox volumio[899]: verbose: CURRENT POSITION 0 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState stateService play Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState currentStatus play Jul 21 08:05:23 bodgebox volumio[899]: info: Received an update from plugin. extracting info from payload Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::servicePushState Jul 21 08:05:23 bodgebox volumio[899]: verbose: In UPNP mode Jul 21 08:05:23 bodgebox volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","artist":"Music Assistant","album":null,"uri":"http://192.168.0.11:8097/single/uuid:27d1bc57-1c71-52eb-9614-c4e984da151c/c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","trackType":""} Jul 21 08:05:23 bodgebox volumio[899]: verbose: CURRENT POSITION 0 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState stateService play Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState currentStatus play Jul 21 08:05:23 bodgebox volumio[899]: info: Received an update from plugin. extracting info from payload Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:23 bodgebox volumio[899]: info: ControllerMpd::pushState Jul 21 08:05:23 bodgebox volumio[1105]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 21 08:05:23 bodgebox volumio[1105]: Dload Upload Total Spent Left Speed Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::servicePushState Jul 21 08:05:23 bodgebox volumio[899]: verbose: In UPNP mode Jul 21 08:05:23 bodgebox volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","artist":"Music Assistant","album":null,"uri":"http://192.168.0.11:8097/single/uuid:27d1bc57-1c71-52eb-9614-c4e984da151c/c08270047b0b4461b9cf76a3ec812eb9.flac?ts=1721541919","trackType":""} Jul 21 08:05:23 bodgebox volumio[899]: verbose: CURRENT POSITION 0 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState stateService play Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::syncState currentStatus play Jul 21 08:05:23 bodgebox volumio[899]: info: Received an update from plugin. extracting info from payload Jul 21 08:05:23 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:23 bodgebox volumio[899]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:23 bodgebox volumio[899]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:23 bodgebox volumio[899]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 137ms Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 111ms Jul 21 08:05:23 bodgebox volumio[899]: info: ------------------------------ 105ms Jul 21 08:05:23 bodgebox volumio[899]: info: Jul 21 08:05:23 bodgebox volumio[899]: ---------------------------- Client requests Volume 30 Jul 21 08:05:23 bodgebox volumio[899]: info: VolumeController::SetAlsaVolume30 Jul 21 08:05:23 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:23 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:23 bodgebox volumio[1105]: [158B blob data] Jul 21 08:05:23 bodgebox volumio[1105]: {"time":1721541923108,"response":"volume Success"}30 Jul 21 08:05:25 bodgebox volumio[1105]: 70 Jul 21 08:05:25 bodgebox volumio[1105]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 21 08:05:25 bodgebox volumio[1105]: Dload Upload Total Spent Left Speed Jul 21 08:05:25 bodgebox volumio[899]: info: Jul 21 08:05:25 bodgebox volumio[899]: ---------------------------- Client requests Volume 70 Jul 21 08:05:25 bodgebox volumio[899]: info: VolumeController::SetAlsaVolume70 Jul 21 08:05:25 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:25 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:25 bodgebox volumio[1105]: [158B blob data] Jul 21 08:05:25 bodgebox volumio[1105]: {"time":1721541925391,"response":"volume Success"}70 Jul 21 08:05:26 bodgebox volumio[1105]: 40 Jul 21 08:05:26 bodgebox volumio[1105]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 21 08:05:26 bodgebox volumio[1105]: Dload Upload Total Spent Left Speed Jul 21 08:05:26 bodgebox volumio[899]: info: Jul 21 08:05:26 bodgebox volumio[899]: ---------------------------- Client requests Volume 40 Jul 21 08:05:26 bodgebox volumio[899]: info: VolumeController::SetAlsaVolume40 Jul 21 08:05:26 bodgebox volumio[899]: info: CoreStateMachine::pushState Jul 21 08:05:26 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:26 bodgebox volumio[1105]: [158B blob data] Jul 21 08:05:26 bodgebox volumio[1105]: {"time":1721541926797,"response":"volume Success"}40 Jul 21 08:05:27 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:05:27 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:27 bodgebox volumio[899]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:27 bodgebox volumio[899]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 21 08:05:27 bodgebox volumio[899]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) Jul 21 08:05:27 bodgebox volumio[899]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jul 21 08:05:27 bodgebox volumio[899]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 21 08:05:27 bodgebox volumio[899]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 21 08:05:27 bodgebox volumio[899]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 21 08:05:27 bodgebox volumio[899]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 21 08:05:27 bodgebox volumio[899]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 21 08:05:27 bodgebox volumio[899]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 21 08:05:27 bodgebox volumio[899]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 21 08:05:27 bodgebox volumio[899]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jul 21 08:05:27 bodgebox volumio[899]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 21 08:05:27 bodgebox volumio[899]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jul 21 08:05:27 bodgebox volumio[899]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jul 21 08:05:27 bodgebox volumio[899]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 21 08:05:27 bodgebox volumio[899]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 21 08:05:37 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:05:37 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:37 bodgebox volumio[899]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:37 bodgebox volumio[899]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 21 08:05:37 bodgebox volumio[899]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) Jul 21 08:05:37 bodgebox volumio[899]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jul 21 08:05:37 bodgebox volumio[899]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 21 08:05:37 bodgebox volumio[899]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 21 08:05:37 bodgebox volumio[899]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 21 08:05:37 bodgebox volumio[899]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 21 08:05:37 bodgebox volumio[899]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 21 08:05:37 bodgebox volumio[899]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 21 08:05:37 bodgebox volumio[899]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 21 08:05:37 bodgebox volumio[899]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Jul 21 08:05:37 bodgebox volumio[899]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 21 08:05:37 bodgebox volumio[899]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Jul 21 08:05:37 bodgebox volumio[899]: at /volumio/node_modules/express/lib/router/index.js:284:7 Jul 21 08:05:37 bodgebox volumio[899]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 21 08:05:37 bodgebox volumio[899]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 21 08:05:37 bodgebox volumio[899]: info: Listing playlists Jul 21 08:05:37 bodgebox volumio[899]: info: Listing playlists Jul 21 08:05:38 bodgebox sudo[2146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 21 08:05:38 bodgebox sudo[2146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 08:05:38 bodgebox sudo[2146]: pam_unix(sudo:session): session closed for user root Jul 21 08:05:38 bodgebox sudo[2148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 08:05:39 bodgebox sudo[2148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 08:05:39 bodgebox sudo[2148]: pam_unix(sudo:session): session closed for user root Jul 21 08:05:39 bodgebox volumio[899]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.10 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 21 08:05:39 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 21 08:05:39 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 08:05:39 bodgebox volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 08:05:39 bodgebox volumio[899]: info: CoreCommandRouter::volumioGetState Jul 21 08:05:39 bodgebox volumio[899]: info: CorePlayQueue::getTrack 0 Jul 21 08:05:39 bodgebox volumio[899]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 08:05:39 bodgebox volumio[899]: TypeError: Cannot read property 'name' of undefined Jul 21 08:05:39 bodgebox volumio[899]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 21 08:05:39 bodgebox volumio[899]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) Jul 21 08:05:39 bodgebox volumio[899]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:55:38) Jul 21 08:05:39 bodgebox volumio[899]: at Socket.emit (events.js:315:20) Jul 21 08:05:39 bodgebox volumio[899]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 21 08:05:39 bodgebox volumio[899]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 21 08:05:39 bodgebox volumio[899]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 08:05:40 bodgebox sudo[2160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 08:04 Jul 21 08:05:40 bodgebox sudo[2160]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"