-- Logs begin at Thu 2020-08-13 13:19:26 UTC, end at Fri 2024-03-29 14:03:55 UTC. -- Mar 29 14:02:25 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 29 14:02:25 volumio volumio[790]: info: CURURI: artists://BACHMAN%20TURNER%20OVERDRIVE Mar 29 14:03:08 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 29 14:03:08 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 14:03:14 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 29 14:03:15 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 29 14:03:36 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Mar 29 14:03:36 volumio volumio[790]: info: [1711721016501] [80s80s] handleBrowseUri curUri: 80s80s Mar 29 14:03:38 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Mar 29 14:03:38 volumio volumio[790]: info: [1711721018785] [80s80s] handleBrowseUri curUri: 80s80s/nineties Mar 29 14:03:38 volumio volumio[790]: info: [1711721018788] [80s80s] getRadioContent url: nineties Mar 29 14:03:44 volumio volumio[790]: info: CoreCommandRouter::volumioAddQueueItems Mar 29 14:03:44 volumio volumio[790]: info: CoreStateMachine::addQueueItems Mar 29 14:03:44 volumio volumio[790]: info: CorePlayQueue::addQueueItems Mar 29 14:03:44 volumio volumio[790]: info: Adding Item to queue: webnineties/4 Mar 29 14:03:44 volumio volumio[790]: info: Exploding uri webnineties/4 in service 80s80s Mar 29 14:03:44 volumio volumio[790]: info: [1711721024132] [80s80s] explodeUri: webnineties/4 Mar 29 14:03:44 volumio volumio[790]: info: CorePlayQueue::saveQueue Mar 29 14:03:44 volumio volumio[790]: info: CoreCommandRouter::volumioPushQueue Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::updateTrackBlock Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrackBlock Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::volumioPlay Mar 29 14:03:46 volumio volumio[790]: UNSET VOLATILE Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::play index 8682 Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::stop Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 14:03:46 volumio volumio[790]: UNSET VOLATILE Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::stPlaybackTimer Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::updateTrackBlock Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrackBlock Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::pushState Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrack 8681 Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::volumioPushState Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::serviceStop Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrack 8681 Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::serviceStop Mar 29 14:03:46 volumio volumio[790]: info: ControllerMpd::stop Mar 29 14:03:46 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 14:03:46 volumio volumio[790]: info: Mar 29 14:03:46 volumio volumio[790]: ---------------------------- MPD announces state update: player Mar 29 14:03:46 volumio volumio[790]: info: ControllerMpd::getState Mar 29 14:03:46 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand status Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::play index undefined Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::startPlaybackTimer Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:46 volumio volumio[790]: info: [1711721026322] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/techno/mp3-192/volumio Mar 29 14:03:46 volumio volumio[790]: info: [1711721026325] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=261&count=2 Mar 29 14:03:46 volumio volumio[790]: verbose: ControllerMpd::parseState Mar 29 14:03:46 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 14:03:46 volumio volumio[790]: verbose: ControllerMpd::parseTrackInfo Mar 29 14:03:46 volumio volumio[790]: info: ControllerMpd::pushState Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::servicePushState Mar 29 14:03:46 volumio volumio[790]: info: CoreStateMachine::pushState Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::volumioPushState Mar 29 14:03:46 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 14:03:46 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:46 volumio volumio[790]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Mar 29 14:03:46 volumio volumio[790]: info: ------------------------------ 641ms Mar 29 14:03:49 volumio volumio[790]: info: [1711721029753] [80s80s] received new event containing 2 songs. Mar 29 14:03:49 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 14:03:51 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 14:03:52 volumio volumio[790]: info: Mar 29 14:03:52 volumio volumio[790]: ---------------------------- MPD announces system playlist update Mar 29 14:03:52 volumio volumio[790]: info: Ignoring MPD Status Update Mar 29 14:03:52 volumio volumio[790]: info: [1711721032008] [80s80s] adding url: http://streams.90s90s.de/techno/mp3-192/volumio Mar 29 14:03:52 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/techno/mp3-192/volumio" Mar 29 14:03:52 volumio volumio[790]: error: updateQueue error: null Mar 29 14:03:52 volumio volumio[790]: info: Mar 29 14:03:52 volumio volumio[790]: ---------------------------- MPD announces system playlist update Mar 29 14:03:52 volumio volumio[790]: info: Ignoring MPD Status Update Mar 29 14:03:52 volumio volumio[790]: info: ------------------------------ 28ms Mar 29 14:03:52 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand play Mar 29 14:03:52 volumio volumio[790]: info: ------------------------------ 20ms Mar 29 14:03:52 volumio volumio[790]: info: [1711721032053] [80s80s] Pushing the next song state: Carl Cox - I Want You Forever (Josh Butler Remix) Mar 29 14:03:52 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:52 volumio volumio[790]: info: CoreCommandRouter::servicePushState Mar 29 14:03:52 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:52 volumio volumio[790]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music128/v4/37/eb/af/37ebaf85-69fe-917d-fbd5-f21f2df92c67/source/600x600bb.jpg","name":"Carl Cox - I Want You Forever (Josh Butler Remix)","title":"I Want You Forever (Josh Butler Remix)","artist":"90s90s Techno","album":"","streaming":true,"disableUiControls":true,"duration":"239","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Mar 29 14:03:52 volumio volumio[790]: verbose: CURRENT POSITION 8682 Mar 29 14:03:52 volumio volumio[790]: info: CoreStateMachine::syncState stateService play Mar 29 14:03:52 volumio volumio[790]: info: CoreStateMachine::syncState currentStatus stop Mar 29 14:03:52 volumio volumio[790]: info: CoreStateMachine::pushState Mar 29 14:03:52 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:52 volumio volumio[790]: info: CoreCommandRouter::volumioPushState Mar 29 14:03:52 volumio volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 14:03:52 volumio volumio[790]: info: [1711721032082] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Mar 29 14:03:52 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:52 volumio volumio[790]: info: CorePlayQueue::getTrack 8683 Mar 29 14:03:53 volumio volumio[790]: info: Mar 29 14:03:53 volumio volumio[790]: ---------------------------- MPD announces state update: player Mar 29 14:03:53 volumio kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error! Mar 29 14:03:53 volumio volumio[790]: info: ControllerMpd::getState Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand status Mar 29 14:03:53 volumio volumio[790]: info: Mar 29 14:03:53 volumio volumio[790]: ---------------------------- MPD announces system playlist update Mar 29 14:03:53 volumio volumio[790]: info: Ignoring MPD Status Update Mar 29 14:03:53 volumio volumio[790]: info: Mar 29 14:03:53 volumio volumio[790]: ---------------------------- MPD announces state update: player Mar 29 14:03:53 volumio volumio[790]: info: ControllerMpd::getState Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand status Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::parseState Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 14:03:53 volumio volumio[790]: info: ------------------------------ 36ms Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::parseState Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::parseTrackInfo Mar 29 14:03:53 volumio volumio[790]: info: ControllerMpd::pushState Mar 29 14:03:53 volumio volumio[790]: info: CoreCommandRouter::servicePushState Mar 29 14:03:53 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:53 volumio volumio[790]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Mar 29 14:03:53 volumio volumio[790]: info: ------------------------------ 75ms Mar 29 14:03:53 volumio volumio[790]: verbose: ControllerMpd::parseTrackInfo Mar 29 14:03:53 volumio volumio[790]: info: ControllerMpd::pushState Mar 29 14:03:53 volumio volumio[790]: info: CoreCommandRouter::servicePushState Mar 29 14:03:53 volumio volumio[790]: info: CorePlayQueue::getTrack 8682 Mar 29 14:03:53 volumio volumio[790]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Mar 29 14:03:53 volumio volumio[790]: info: ------------------------------ 338ms Mar 29 14:03:54 volumio volumio[790]: info: [1711721034161] [80s80s] Failed to query api, status code: 404 Mar 29 14:03:54 volumio volumio[790]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 14:03:54 volumio volumio[790]: ReferenceError: station is not defined Mar 29 14:03:54 volumio volumio[790]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Mar 29 14:03:54 volumio volumio[790]: at Object.onceWrapper (events.js:315:30) Mar 29 14:03:54 volumio volumio[790]: at emitOne (events.js:116:13) Mar 29 14:03:54 volumio volumio[790]: at ClientRequest.emit (events.js:211:7) Mar 29 14:03:54 volumio volumio[790]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Mar 29 14:03:54 volumio volumio[790]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Mar 29 14:03:54 volumio volumio[790]: at Socket.socketOnData (_http_client.js:440:20) Mar 29 14:03:54 volumio volumio[790]: at emitOne (events.js:116:13) Mar 29 14:03:54 volumio volumio[790]: at Socket.emit (events.js:211:7) Mar 29 14:03:54 volumio volumio[790]: at addChunk (_stream_readable.js:263:12) Mar 29 14:03:54 volumio volumio[790]: at readableAddChunk (_stream_readable.js:250:11) Mar 29 14:03:54 volumio volumio[790]: at Socket.Readable.push (_stream_readable.js:208:10) Mar 29 14:03:54 volumio volumio[790]: at TCP.onread (net.js:607:20) Mar 29 14:03:54 volumio volumio[790]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 14:03:55 volumio sudo[3806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 14:02 Mar 29 14:03:55 volumio sudo[3806]: 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="79c2e7e29d04526018e922852ec460ffc0707dd1" VOLUMIO_FE_VERSION="77c86e8a1bfb19b724ead35c47d417c4832cf290" VOLUMIO_BE_VERSION="f30dbcf35403287bd1b5d6a60fa82e3da7871c6c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Jul 16 18:40:05 CEST 2020" VOLUMIO_VERSION="2.799" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="3640dc4c81092e5cb33682a0d71ffe92"