-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-01-13 16:42:47 CET. -- Jan 13 16:41:23 office volumio[845]: info: Jan 13 16:41:23 office volumio[845]: ---------------------------- MPD announces system playlist update Jan 13 16:41:23 office volumio[845]: info: Ignoring MPD Status Update Jan 13 16:41:23 office volumio[845]: info: Jan 13 16:41:23 office volumio[845]: ---------------------------- MPD announces state update: player Jan 13 16:41:23 office volumio[845]: info: ControllerMpd::getState Jan 13 16:41:23 office volumio[845]: verbose: ControllerMpd::sendMpdCommand status Jan 13 16:41:23 office volumio[845]: info: ------------------------------ 1ms Jan 13 16:41:23 office volumio[845]: info: sendMpdCommand status took 1 milliseconds Jan 13 16:41:23 office volumio[845]: verbose: ControllerMpd::parseState Jan 13 16:41:23 office volumio[845]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 16:41:23 office volumio[845]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 13 16:41:23 office volumio[845]: verbose: ControllerMpd::parseTrackInfo Jan 13 16:41:23 office volumio[845]: info: ControllerMpd::pushState Jan 13 16:41:23 office volumio[845]: info: CoreCommandRouter::servicePushState Jan 13 16:41:23 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:41:23 office volumio[845]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1770363,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"WDR 3 Tonart mit Susanne Herzog","artist":"WDR 3, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://f111.rndfnk.com/ard/wdr/wdr3/live/mp3/256/stream.mp3?cid=01FBS0C9GMJJE2D5WXZHFQY7HG&sid=2m3yi3VKD6uTKZQ1WAUfHVJX1sO&token=iml5hG3i8vu-m-Bxc1Td5pdqvMotU3N_eKPlV-jp3Ok&tvf=ryaQ6D4y9RdmMTExLnJuZGZuay5jb20","trackType":""} Jan 13 16:41:23 office volumio[845]: verbose: CURRENT POSITION 0 Jan 13 16:41:23 office volumio[845]: info: CoreStateMachine::syncState stateService play Jan 13 16:41:23 office volumio[845]: info: CoreStateMachine::syncState currentStatus play Jan 13 16:41:23 office volumio[845]: info: Received an update from plugin. extracting info from payload Jan 13 16:41:23 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 13 16:41:23 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:41:23 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 16:41:23 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:41:23 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:41:23 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:41:23 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:41:23 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:41:23 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:41:23 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:41:23 office volumio[845]: info: ------------------------------ 15ms Jan 13 16:41:23 office volumio[845]: info: [ASDebug] CurState: play PrevState: play Jan 13 16:41:23 office volumio[845]: info: [ASDebug] CurState: play PrevState: play Jan 13 16:41:23 office volumio[845]: info: [ASDebug] CurState: play PrevState: play Jan 13 16:41:23 office volumio[845]: info: [ASDebug] CurState: play PrevState: play Jan 13 16:42:22 office volumio[845]: info: Tunnel connection is inactive, restarting it Jan 13 16:42:22 office volumio[845]: info: Starting Tunnel 1 Jan 13 16:42:22 office volumio[845]: info: Starting Tunnel Connection Checker Jan 13 16:42:22 office sudo[14542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 13 16:42:22 office sudo[14542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 16:42:22 office autossh[13731]: received signal to exit (15) Jan 13 16:42:22 office systemd[1]: Stopping MyVolumio SSH Tunnel... Jan 13 16:42:22 office systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Jan 13 16:42:22 office systemd[1]: sshtunnel.service: Succeeded. Jan 13 16:42:22 office volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 16:42:22 office systemd[1]: Stopped MyVolumio SSH Tunnel. Jan 13 16:42:22 office volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 16:42:22 office systemd[1]: Started MyVolumio SSH Tunnel. Jan 13 16:42:22 office sudo[14542]: pam_unix(sudo:session): session closed for user root Jan 13 16:42:22 office volumio[845]: info: Remote SSH Started Jan 13 16:42:22 office autossh[14547]: port set to 0, monitoring disabled Jan 13 16:42:22 office autossh[14547]: starting ssh (count 1) Jan 13 16:42:22 office autossh[14547]: ssh child pid is 14550 Jan 13 16:42:22 office volumio[845]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jan 13 16:42:22 office volumio[845]: info: CoreCommandRouter::volumioGetState Jan 13 16:42:30 office volumio[845]: info: Jan 13 16:42:30 office volumio[845]: ---------------------------- MPD announces system playlist update Jan 13 16:42:30 office volumio[845]: info: Ignoring MPD Status Update Jan 13 16:42:30 office volumio[845]: info: Jan 13 16:42:30 office volumio[845]: ---------------------------- MPD announces state update: player Jan 13 16:42:30 office volumio[845]: info: ControllerMpd::getState Jan 13 16:42:30 office volumio[845]: verbose: ControllerMpd::sendMpdCommand status Jan 13 16:42:30 office volumio[845]: info: ------------------------------ 2ms Jan 13 16:42:30 office volumio[845]: info: sendMpdCommand status took 1 milliseconds Jan 13 16:42:30 office volumio[845]: verbose: ControllerMpd::parseState Jan 13 16:42:30 office volumio[845]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 16:42:30 office volumio[845]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 13 16:42:30 office volumio[845]: verbose: ControllerMpd::parseTrackInfo Jan 13 16:42:30 office volumio[845]: info: ControllerMpd::pushState Jan 13 16:42:30 office volumio[845]: info: CoreCommandRouter::servicePushState Jan 13 16:42:30 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:30 office volumio[845]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1837729,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"César Franck - Les Éolides (Orig), FWV 43","artist":"WDR 3, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://f111.rndfnk.com/ard/wdr/wdr3/live/mp3/256/stream.mp3?cid=01FBS0C9GMJJE2D5WXZHFQY7HG&sid=2m3yi3VKD6uTKZQ1WAUfHVJX1sO&token=iml5hG3i8vu-m-Bxc1Td5pdqvMotU3N_eKPlV-jp3Ok&tvf=ryaQ6D4y9RdmMTExLnJuZGZuay5jb20","trackType":""} Jan 13 16:42:30 office volumio[845]: verbose: CURRENT POSITION 0 Jan 13 16:42:30 office volumio[845]: info: CoreStateMachine::syncState stateService play Jan 13 16:42:30 office volumio[845]: info: CoreStateMachine::syncState currentStatus play Jan 13 16:42:30 office volumio[845]: info: Received an update from plugin. extracting info from payload Jan 13 16:42:30 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 13 16:42:30 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:42:30 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 16:42:30 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:42:30 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:42:30 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:42:30 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:42:30 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:42:30 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:42:30 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:42:30 office volumio[845]: info: ------------------------------ 18ms Jan 13 16:42:30 office volumio[845]: info: [ASDebug] CurState: play PrevState: play Jan 13 16:42:30 office volumio[845]: info: [ASDebug] CurState: play PrevState: play Jan 13 16:42:37 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jan 13 16:42:37 office volumio[845]: info: browseTIDALUri took 61 milliseconds Jan 13 16:42:37 office volumio[845]: info: Preload queue cleared Jan 13 16:42:37 office volumio[845]: info: Preload queue cleared Jan 13 16:42:38 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jan 13 16:42:38 office volumio[845]: info: browseTIDALUri took 378 milliseconds Jan 13 16:42:38 office volumio[845]: info: Preload queue cleared Jan 13 16:42:41 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Jan 13 16:42:43 office volumio[845]: info: browseTIDALUri took 1835 milliseconds Jan 13 16:42:43 office volumio[845]: info: Preload queue cleared Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/136552599 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/347013557 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/299400559 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/238631228 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/284676738 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/95837472 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/136552600 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/93158823 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/16944106 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/292285770 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/93724712 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/59739906 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/95837468 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/99034253 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/47344103 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/89758925 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/93387647 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/16944109 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/299400553 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/319063538 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/319058787 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/306129310 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/135641584 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/77613080 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/16944105 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/93387643 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/302516603 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/127657188 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/94373350 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/332268441 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/93724710 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/265352605 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/129932495 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/77613705 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/80896613 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/127657182 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/149116059 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/156470199 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/100930968 Jan 13 16:42:43 office volumio[845]: info: Preloading song: tidal://song/79773660 Jan 13 16:42:43 office volumio[845]: info: Exploding uri tidal://song/136552599 in service tidal Jan 13 16:42:43 office volumio[845]: info: Exploding uri tidal://song/347013557 in service tidal Jan 13 16:42:43 office volumio[845]: info: Exploding uri tidal://song/299400559 in service tidal Jan 13 16:42:43 office volumio[845]: info: Exploding uri tidal://song/238631228 in service tidal Jan 13 16:42:43 office volumio[845]: info: Exploding uri tidal://song/284676738 in service tidal Jan 13 16:42:43 office volumio[845]: info: Exploding uri tidal://song/95837472 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/136552600 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/93158823 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/16944106 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/292285770 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 338 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/93724712 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 170 milliseconds Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 300 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/59739906 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 285 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/95837468 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 192 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/99034253 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 171 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/47344103 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/89758925 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/93387647 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 188 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/16944109 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 871 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/299400553 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 218 milliseconds Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 887 milliseconds Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 199 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/319063538 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 872 milliseconds Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 188 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/319058787 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 462 milliseconds Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 169 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/306129310 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 459 milliseconds Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 868 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/135641584 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 174 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/77613080 in service tidal Jan 13 16:42:44 office volumio[845]: info: explodeTIDALUri took 179 milliseconds Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/16944105 in service tidal Jan 13 16:42:44 office volumio[845]: info: Exploding uri tidal://song/93387643 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 874 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 201 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/302516603 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 199 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/127657188 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 467 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 190 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/94373350 in service tidal Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/332268441 in service tidal Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/93724710 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 478 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/265352605 in service tidal Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/129932495 in service tidal Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/77613705 in service tidal Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/80896613 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 470 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/127657182 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 265 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 464 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/149116059 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 469 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/156470199 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 476 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/100930968 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 204 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 495 milliseconds Jan 13 16:42:45 office volumio[845]: info: Exploding uri tidal://song/79773660 in service tidal Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 194 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 509 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 215 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 481 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 453 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 180 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 486 milliseconds Jan 13 16:42:45 office volumio[845]: info: explodeTIDALUri took 359 milliseconds Jan 13 16:42:46 office volumio[845]: info: Preload queue cleared Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::ClearQueue Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::stop Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::stPlaybackTimer Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::updateTrackBlock Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrackBlock Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::serviceStop Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::serviceStop Jan 13 16:42:46 office volumio[845]: info: [1736782966269] ControllerWebradio::stop Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::clearPlayQueue Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::saveQueue Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPushQueue Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::addQueueItems Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::addQueueItems Jan 13 16:42:46 office volumio[845]: info: Preload queue cleared Jan 13 16:42:46 office volumio[845]: info: Adding Item to queue: tidal://mymusic/mixes/0024dff0271c20e1ed6a687c11bb43 Jan 13 16:42:46 office volumio[845]: info: Exploding uri tidal://mymusic/mixes/0024dff0271c20e1ed6a687c11bb43 in service tidal Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: Jan 13 16:42:46 office volumio[845]: ---------------------------- MPD announces state update: player Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand stop took 25 milliseconds Jan 13 16:42:46 office volumio[845]: info: ControllerMpd::getState Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand status Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand status took 1 milliseconds Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::parseState Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand playlistinfo took 26 milliseconds Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::parseTrackInfo Jan 13 16:42:46 office volumio[845]: info: ControllerMpd::pushState Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::servicePushState Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"César Franck - Les Éolides (Orig), FWV 43","artist":"WDR 3, Westdeutscher Rundfunk Koeln","album":null,"uri":"https://f111.rndfnk.com/ard/wdr/wdr3/live/mp3/256/stream.mp3?cid=01FBS0C9GMJJE2D5WXZHFQY7HG&sid=2m3yi3VKD6uTKZQ1WAUfHVJX1sO&token=iml5hG3i8vu-m-Bxc1Td5pdqvMotU3N_eKPlV-jp3Ok&tvf=ryaQ6D4y9RdmMTExLnJuZGZuay5jb20","trackType":""} Jan 13 16:42:46 office volumio[845]: verbose: CURRENT POSITION 0 Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::syncState stateService stop Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::syncState currentStatus stop Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:42:46 office volumio[845]: info: No code Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::pushState Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPushState Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output update for this device Jan 13 16:42:46 office volumio[845]: info: MRS: Pushing multiroomSync output Jan 13 16:42:46 office volumio[845]: info: ------------------------------ 55ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: [ASDebug] CurState: stop PrevState: play Jan 13 16:42:46 office volumio[845]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jan 13 16:42:46 office volumio[845]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 13 16:42:46 office volumio[845]: info: explodeTIDALUri took 672 milliseconds Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPushQueue Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::saveQueue Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::updateTrackBlock Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrackBlock Jan 13 16:42:46 office volumio[845]: info: CoreCommandRouter::volumioPlay Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::play index 0 Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::stop Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::play index undefined Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::startPlaybackTimer Jan 13 16:42:46 office volumio[845]: info: CorePlayQueue::getTrack 0 Jan 13 16:42:46 office volumio[845]: info: [1736782966955] ControllerTidal::clearAddPlayTrack Jan 13 16:42:46 office volumio[845]: info: Getting stream with soundQuality HI_RES Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand stop took 9 milliseconds Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 16:42:46 office volumio[845]: info: Jan 13 16:42:46 office volumio[845]: ---------------------------- MPD announces system playlist update Jan 13 16:42:46 office volumio[845]: info: Ignoring MPD Status Update Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand clear took 0 milliseconds Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/136552599&soundQuality=HI_RES" Jan 13 16:42:46 office volumio[845]: error: updateQueue error: null Jan 13 16:42:46 office volumio[845]: info: Jan 13 16:42:46 office volumio[845]: ---------------------------- MPD announces system playlist update Jan 13 16:42:46 office volumio[845]: info: Ignoring MPD Status Update Jan 13 16:42:46 office volumio[845]: info: ------------------------------ 2ms Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/136552599&soundQuality=HI_RES" took 1 milliseconds Jan 13 16:42:46 office volumio[845]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 13 16:42:46 office volumio[845]: verbose: ControllerMpd::sendMpdCommand play Jan 13 16:42:46 office volumio[845]: info: ------------------------------ 1ms Jan 13 16:42:46 office volumio[845]: info: sendMpdCommand play took 2 milliseconds Jan 13 16:42:46 office volumio[845]: STREAMING PROXY: Handling url /?data=tidal://song/136552599&soundQuality=HI_RES Jan 13 16:42:47 office volumio[845]: info: Executing endpoint getStreamUrltidal Jan 13 16:42:47 office volumio[845]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI Jan 13 16:42:47 office volumio[845]: info: [ASDebug] Togle GPIO: OFF Jan 13 16:42:47 office volumio[845]: info: [ASDebug] Togle GPIO: OFF Jan 13 16:42:47 office volumio[845]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 16:42:47 office volumio[845]: Error: ESPIPE: invalid seek, write Jan 13 16:42:47 office volumio[845]: at Object.writeSync (fs.js:711:3) Jan 13 16:42:47 office volumio[845]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Jan 13 16:42:47 office volumio[845]: at AmpSwitchController.off (/data/plugins/system_controller/ampswitch/index.js:221:23) Jan 13 16:42:47 office volumio[845]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:195:88) Jan 13 16:42:47 office volumio[845]: at listOnTimeout (internal/timers.js:554:17) Jan 13 16:42:47 office volumio[845]: at processTimers (internal/timers.js:497:7) { Jan 13 16:42:47 office volumio[845]: errno: -29, Jan 13 16:42:47 office volumio[845]: syscall: 'write', Jan 13 16:42:47 office volumio[845]: code: 'ESPIPE' Jan 13 16:42:47 office volumio[845]: } Jan 13 16:42:47 office volumio[845]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 16:42:47 office sudo[14650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-13 16:41 Jan 13 16:42:47 office sudo[14650]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"