-- Logs begin at Wed 2024-02-28 16:18:50 UTC, end at Mon 2024-11-25 22:38:43 UTC. -- Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 22:37:00 volumiopi volumio[865]: info: [1732574220000] CoreMusicLibrary::Adding element Media Servers Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 22:37:00 volumiopi volumio[865]: info: [1732574220052] CoreMusicLibrary::Adding element Last_100 Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 22:37:00 volumiopi volumio[865]: info: [1732574220058] CoreMusicLibrary::Adding element Webradio Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 22:37:00 volumiopi volumio[865]: info: [1732574220105] CoreMusicLibrary::Adding element 80s80s Radio Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:00 volumiopi volumio[865]: info: TuneIn addToBrowseSources Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 22:37:00 volumiopi volumio[865]: info: [1732574220113] CoreMusicLibrary::Adding element TuneIn Radio Nov 25 22:37:00 volumiopi sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 25 22:37:00 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:00 volumiopi sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:00 volumiopi volumio[865]: info: $ref=$, _isPromise=true, _successFn=undefined, _failFn=undefined, $ref=$, _boundArgs=null, _hasContext=false, _nextContext=undefined, _currentContext=undefined Nov 25 22:37:00 volumiopi volumio[865]: info: ------------------------------------------- Nov 25 22:37:00 volumiopi volumio[865]: info: ----- MyVolumio plugins startup ---- Nov 25 22:37:00 volumiopi volumio[865]: info: ------------------------------------------- Nov 25 22:37:00 volumiopi volumio[865]: info: Loading plugins from folder /myvolumio/plugins Nov 25 22:37:00 volumiopi systemd[1]: Starting Start Volumio Kiosk... Nov 25 22:37:00 volumiopi volumio[865]: info: Loading plugins from folder /data/myvolumio/plugins Nov 25 22:37:00 volumiopi systemd[1]: Started Start Volumio Kiosk. Nov 25 22:37:00 volumiopi volumio[865]: info: Loading plugin "cd_controller"... Nov 25 22:37:00 volumiopi systemd[1003]: Failed at step EXEC spawning /usr/bin/startx: No such file or directory Nov 25 22:37:00 volumiopi systemd[1]: volumio-kiosk.service: main process exited, code=exited, status=203/EXEC Nov 25 22:37:00 volumiopi systemd[1]: Unit volumio-kiosk.service entered failed state. Nov 25 22:37:00 volumiopi sudo[998]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:00 volumiopi volumio[865]: info: Loading plugin "streaming_services"... Nov 25 22:37:00 volumiopi volumio[865]: info: Loading plugin "my_volumio"... Nov 25 22:37:01 volumiopi volumio[865]: info: Adding CD REST API Endpoints Nov 25 22:37:01 volumiopi volumio[865]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Nov 25 22:37:01 volumiopi volumio[865]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Nov 25 22:37:01 volumiopi volumio[865]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Nov 25 22:37:01 volumiopi volumio[865]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Nov 25 22:37:01 volumiopi volumio[865]: info: Detecting CD presence Nov 25 22:37:01 volumiopi volumio[865]: info: Streaming services startup Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: Starting MyVolumio Remote Streaming Endpoints Nov 25 22:37:01 volumiopi sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 22:37:01 volumiopi sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:01 volumiopi systemd[1]: Stopping Volumio Streaming Daemon... Nov 25 22:37:01 volumiopi systemd[1]: Starting Volumio Streaming Daemon... Nov 25 22:37:01 volumiopi systemd[1]: Started Volumio Streaming Daemon. Nov 25 22:37:01 volumiopi sudo[1009]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:01 volumiopi volumio[865]: info: Loading i18n strings for locale en Nov 25 22:37:01 volumiopi volumio-streaming-daemon[1015]: ############################ Nov 25 22:37:01 volumiopi volumio-streaming-daemon[1015]: # Volumio Streaming Daemon # Nov 25 22:37:01 volumiopi volumio-streaming-daemon[1015]: # Running on port 7777 # Nov 25 22:37:01 volumiopi volumio-streaming-daemon[1015]: ############################ Nov 25 22:37:01 volumiopi volumio[865]: Updating browse sources language Nov 25 22:37:01 volumiopi volumio[865]: Cannot find translation for sourceMedia Servers Nov 25 22:37:01 volumiopi volumio[865]: Cannot find translation for source80s80s Radio Nov 25 22:37:01 volumiopi volumio[865]: Cannot find translation for sourceTuneIn Radio Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::initPlayerControls Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 22:37:01 volumiopi volumio[865]: info: BOOT COMPLETED Nov 25 22:37:01 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 22:37:06 volumiopi volumio-remote-updater[633]: [2024-11-25 22:37:06] [connect] Successful connection Nov 25 22:37:06 volumiopi volumio[865]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Nov 25 22:37:06 volumiopi volumio[865]: info: CoreCommandRouter::Close All Modals sent Nov 25 22:37:06 volumiopi volumio[865]: info: CoreCommandRouter::Close All Modals sent Nov 25 22:37:06 volumiopi volumio[865]: Express server listening on port 3000 Nov 25 22:37:07 volumiopi volumio[865]: Volumio Calling Home Nov 25 22:37:07 volumiopi volumio[865]: info: MyVolumio not started Nov 25 22:37:07 volumiopi volumio[865]: info: CoreStateMachine::resetVolumioState Nov 25 22:37:07 volumiopi volumio[865]: info: CoreStateMachine::getcurrentVolume Nov 25 22:37:07 volumiopi volumio[865]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 22:37:07 volumiopi sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:07 volumiopi sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:07 volumiopi sudo[1037]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:07 volumiopi volumio[865]: info: Setting Device type: Raspberry PI Nov 25 22:37:07 volumiopi volumio[865]: info: Volumio Kiosk Started Nov 25 22:37:07 volumiopi volumio[865]: info: Kiosk Started Nov 25 22:37:07 volumiopi volumio[865]: info: MPD running with PID662 ,establishing connection Nov 25 22:37:07 volumiopi sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Nov 25 22:37:07 volumiopi sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:07 volumiopi sudo[1047]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:07 volumiopi volumio-remote-updater[633]: [2024-11-25 22:37:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1732574226 101 Nov 25 22:37:07 volumiopi volumio[865]: info: VolumeController:: Volume=2 Mute =false Nov 25 22:37:07 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:37:07 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:37:07 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:37:07 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:37:07 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 25 22:37:08 volumiopi volumio[865]: info: Reloading queue from file Nov 25 22:37:08 volumiopi volumio[865]: info: Nov 25 22:37:08 volumiopi volumio[865]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Nov 25 22:37:08 volumiopi volumio[865]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Nov 25 22:37:08 volumiopi volumio[865]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Nov 25 22:37:08 volumiopi volumio[865]: at emitOne (events.js:116:13) Nov 25 22:37:08 volumiopi volumio[865]: at Socket.emit (events.js:211:7) Nov 25 22:37:08 volumiopi volumio[865]: at addChunk (_stream_readable.js:263:12) Nov 25 22:37:08 volumiopi volumio[865]: at readableAddChunk (_stream_readable.js:246:13) Nov 25 22:37:08 volumiopi volumio[865]: at Socket.Readable.push (_stream_readable.js:208:10) Nov 25 22:37:08 volumiopi volumio[865]: at Pipe.onread (net.js:607:20) Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::setRepeat true single undefined Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:37:08 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::setRandom false Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:37:08 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: local Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: music Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: talk Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: sports Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: location Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: language Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushing element: podcast Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Pushed elements: 7 Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: local Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: music Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: talk Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: sports Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: location Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: language Nov 25 22:37:08 volumiopi volumio[865]: info: [TuneIn] Element: podcast Nov 25 22:37:08 volumiopi sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Nov 25 22:37:08 volumiopi sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:08 volumiopi sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Nov 25 22:37:08 volumiopi sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:08 volumiopi sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 25 22:37:08 volumiopi sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:08 volumiopi systemd[1]: Starting ShairportSync AirTunes receiver... Nov 25 22:37:08 volumiopi systemd[1]: Started ShairportSync AirTunes receiver. Nov 25 22:37:08 volumiopi systemd[1]: Stopping ShairportSync AirTunes receiver... Nov 25 22:37:08 volumiopi sudo[1059]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:08 volumiopi systemd[1]: Starting UPnP Renderer front-end to MPD... Nov 25 22:37:08 volumiopi systemd[1]: Started UPnP Renderer front-end to MPD. Nov 25 22:37:08 volumiopi systemd[1]: Starting ShairportSync AirTunes receiver... Nov 25 22:37:08 volumiopi systemd[1]: Started ShairportSync AirTunes receiver. Nov 25 22:37:08 volumiopi sudo[1061]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:08 volumiopi sudo[1068]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:08 volumiopi shairport-sync[1082]: Successful Startup Nov 25 22:37:08 volumiopi volumio[865]: info: Shairport-Sync Started Nov 25 22:37:08 volumiopi volumio[865]: Error adding Membership: Error: addMembership EINVAL Nov 25 22:37:08 volumiopi volumio[865]: info: Upmpdcli Daemon Started Nov 25 22:37:08 volumiopi volumio[865]: info: Shairport-Sync Started Nov 25 22:37:08 volumiopi volumio[865]: info: CoreCommandRouter::volumioGetState Nov 25 22:37:08 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:37:08 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:37:12 volumiopi volumio[865]: info: Fetching Streaming Services browse cache Nov 25 22:37:12 volumiopi volumio[865]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Nov 25 22:37:12 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:12 volumiopi volumio[865]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Nov 25 22:37:12 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:13 volumiopi volumio[865]: Discovery: adding e27fba6f-ee54-4376-b604-c2939fa12253 Nov 25 22:37:13 volumiopi volumio[865]: info: mDNS: Found device Volumiopi Nov 25 22:37:13 volumiopi sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:13 volumiopi sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:13 volumiopi sudo[1117]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:14 volumiopi sudo[1133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 22:37:14 volumiopi sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:14 volumiopi sudo[1133]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:14 volumiopi sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:14 volumiopi sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:14 volumiopi sudo[1136]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::volumioGetState Nov 25 22:37:14 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:37:14 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 25 22:37:14 volumiopi sudo[1151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:14 volumiopi sudo[1151]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:14 volumiopi sudo[1151]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 22:37:14 volumiopi volumio[865]: info: Listing playlists Nov 25 22:37:14 volumiopi sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:14 volumiopi sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:14 volumiopi sudo[1157]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:17 volumiopi volumio[865]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 22:37:17 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 22:37:17 volumiopi volumio[865]: info: CoreCommandRouter::volumioGetState Nov 25 22:37:17 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:37:17 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:37:17 volumiopi sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:17 volumiopi sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:17 volumiopi sudo[1190]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:17 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 22:37:17 volumiopi volumio[865]: info: Listing playlists Nov 25 22:37:17 volumiopi sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:37:17 volumiopi sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:37:17 volumiopi sudo[1195]: pam_unix(sudo:session): session closed for user root Nov 25 22:37:23 volumiopi volumio[865]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.575&uuid=c0e0657c26d2293cbb28ff5f5146f020" http://updates.volumio.org:7070/downloader-v1/track-device Nov 25 22:37:23 volumiopi volumio[865]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 25 22:37:23 volumiopi volumio[865]: Dload Upload Total Spent Left Speed Nov 25 22:37:23 volumiopi volumio[865]: [709B blob data] Nov 25 22:37:23 volumiopi volumio[865]: retrying in 5 seconds, trial 0 Nov 25 22:37:23 volumiopi volumio[865]: Volumio Calling Home Nov 25 22:37:30 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 22:37:30 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 22:37:33 volumiopi volumio[865]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.575&uuid=c0e0657c26d2293cbb28ff5f5146f020" http://updates.volumio.org:7070/downloader-v1/track-device Nov 25 22:37:33 volumiopi volumio[865]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 25 22:37:33 volumiopi volumio[865]: Dload Upload Total Spent Left Speed Nov 25 22:37:33 volumiopi volumio[865]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Nov 25 22:37:33 volumiopi volumio[865]: retrying in 5 seconds, trial 1 Nov 25 22:37:33 volumiopi volumio[865]: Volumio Calling Home Nov 25 22:37:44 volumiopi volumio[865]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.575&uuid=c0e0657c26d2293cbb28ff5f5146f020" http://updates.volumio.org:7070/downloader-v1/track-device Nov 25 22:37:44 volumiopi volumio[865]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 25 22:37:44 volumiopi volumio[865]: Dload Upload Total Spent Left Speed Nov 25 22:37:44 volumiopi volumio[865]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Nov 25 22:37:44 volumiopi volumio[865]: retrying in 5 seconds, trial 2 Nov 25 22:37:44 volumiopi volumio[865]: Volumio Calling Home Nov 25 22:38:05 volumiopi volumio[865]: info: CoreCommandRouter::volumioPlay Nov 25 22:38:05 volumiopi volumio[865]: UNSET VOLATILE Nov 25 22:38:05 volumiopi volumio[865]: info: CoreStateMachine::play index undefined Nov 25 22:38:05 volumiopi volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 22:38:05 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:05 volumiopi volumio[865]: info: CoreStateMachine::startPlaybackTimer Nov 25 22:38:05 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:05 volumiopi volumio[865]: info: [1732574285638] ControllerWebradio::clearAddPlayTrack Nov 25 22:38:05 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand stop Nov 25 22:38:05 volumiopi volumio[865]: info: sending command... Nov 25 22:38:05 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:05 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand clear Nov 25 22:38:05 volumiopi volumio[865]: info: sending command... Nov 25 22:38:05 volumiopi volumio[865]: info: Nov 25 22:38:05 volumiopi volumio[865]: ---------------------------- MPD announces system playlist update Nov 25 22:38:05 volumiopi volumio[865]: info: Ignoring MPD Status Update Nov 25 22:38:05 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:05 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand load "https://rfcm.streamguys1.com/smoothjazz-mp3?aw_0_1st.skey=1709164538&aw_0_1st.abtest=&aw_0_1st.stationId=s249973&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g71&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en" Nov 25 22:38:05 volumiopi volumio[865]: info: sending command... Nov 25 22:38:05 volumiopi volumio[865]: info: Nov 25 22:38:05 volumiopi volumio[865]: info: ------------------------------ 7ms Nov 25 22:38:08 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand add "https://rfcm.streamguys1.com/smoothjazz-mp3?aw_0_1st.skey=1709164538&aw_0_1st.abtest=&aw_0_1st.stationId=s249973&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g71&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en" Nov 25 22:38:08 volumiopi volumio[865]: info: sending command... Nov 25 22:38:08 volumiopi volumio[865]: info: Nov 25 22:38:08 volumiopi volumio[865]: ---------------------------- MPD announces system playlist update Nov 25 22:38:08 volumiopi volumio[865]: info: Ignoring MPD Status Update Nov 25 22:38:08 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:08 volumiopi volumio[865]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 25 22:38:08 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand play Nov 25 22:38:08 volumiopi volumio[865]: info: sending command... Nov 25 22:38:08 volumiopi volumio[865]: info: ------------------------------ 7ms Nov 25 22:38:08 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:10 volumiopi volumio[865]: info: Nov 25 22:38:10 volumiopi volumio[865]: ---------------------------- MPD announces state update: player Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::getState Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand status Nov 25 22:38:10 volumiopi volumio[865]: info: sending command... Nov 25 22:38:10 volumiopi volumio[865]: info: Nov 25 22:38:10 volumiopi volumio[865]: ---------------------------- MPD announces system playlist update Nov 25 22:38:10 volumiopi volumio[865]: info: Ignoring MPD Status Update Nov 25 22:38:10 volumiopi volumio[865]: info: Nov 25 22:38:10 volumiopi volumio[865]: ---------------------------- MPD announces state update: player Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::getState Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand status Nov 25 22:38:10 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:10 volumiopi volumio[865]: info: sending command... Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::parseState Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 22:38:10 volumiopi volumio[865]: info: sending command... Nov 25 22:38:10 volumiopi volumio[865]: info: ------------------------------ 11ms Nov 25 22:38:10 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:10 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::parseState Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::parseTrackInfo Nov 25 22:38:10 volumiopi volumio[865]: info: sending command... Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::pushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreCommandRouter::servicePushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::syncState Nov 25 22:38:10 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:10 volumiopi volumio[865]: info: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Marion Meadows - Let The Top Down","artist":null,"album":null,"uri":"https://rfcm.streamguys1.com/smoothjazz-mp3?aw_0_1st.skey=1709164538&aw_0_1st.abtest=&aw_0_1st.stationId=s249973&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g71&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en","trackType":""} Nov 25 22:38:10 volumiopi volumio[865]: info: CURRENT POSITION 0 Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::syncState stateService play Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::syncState currentStatus stop Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:10 volumiopi volumio[865]: info: ------------------------------ 58ms Nov 25 22:38:10 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::parseTrackInfo Nov 25 22:38:10 volumiopi volumio[865]: info: ControllerMpd::pushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreCommandRouter::servicePushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::syncState Nov 25 22:38:10 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:10 volumiopi sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:10 volumiopi volumio[865]: info: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Marion Meadows - Let The Top Down","artist":null,"album":null,"uri":"https://rfcm.streamguys1.com/smoothjazz-mp3?aw_0_1st.skey=1709164538&aw_0_1st.abtest=&aw_0_1st.stationId=s249973&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g71&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en","trackType":""} Nov 25 22:38:10 volumiopi volumio[865]: info: CURRENT POSITION 0 Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::syncState stateService play Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::syncState currentStatus play Nov 25 22:38:10 volumiopi volumio[865]: info: Received an update from plugin. extracting info from payload Nov 25 22:38:10 volumiopi sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:10 volumiopi sudo[1575]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:10 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:11 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:11 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:11 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:11 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:11 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:11 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:11 volumiopi sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:11 volumiopi sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:11 volumiopi sudo[1584]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:11 volumiopi volumio[865]: info: ------------------------------ 125ms Nov 25 22:38:11 volumiopi sudo[1591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:11 volumiopi sudo[1591]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:11 volumiopi sudo[1591]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:14 volumiopi volumio[865]: info: VolumeController::SetAlsaVolume31 Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:14 volumiopi volumio[865]: info: Nov 25 22:38:14 volumiopi volumio[865]: ---------------------------- MPD announces state update: mixer Nov 25 22:38:14 volumiopi volumio[865]: info: ControllerMpd::getState Nov 25 22:38:14 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand status Nov 25 22:38:14 volumiopi volumio[865]: info: sending command... Nov 25 22:38:14 volumiopi sudo[1625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:14 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:14 volumiopi volumio[865]: info: ControllerMpd::parseState Nov 25 22:38:14 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 22:38:14 volumiopi volumio[865]: info: sending command... Nov 25 22:38:14 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:14 volumiopi volumio[865]: info: ControllerMpd::parseTrackInfo Nov 25 22:38:14 volumiopi volumio[865]: info: ControllerMpd::pushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::servicePushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::syncState Nov 25 22:38:14 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:14 volumiopi volumio[865]: info: STATE SERVICE {"status":"play","position":0,"seek":4365,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Marion Meadows - Let The Top Down","artist":null,"album":null,"uri":"https://rfcm.streamguys1.com/smoothjazz-mp3?aw_0_1st.skey=1709164538&aw_0_1st.abtest=&aw_0_1st.stationId=s249973&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g71&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en","trackType":""} Nov 25 22:38:14 volumiopi volumio[865]: info: CURRENT POSITION 0 Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::syncState stateService play Nov 25 22:38:14 volumiopi sudo[1625]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:14 volumiopi sudo[1625]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::syncState currentStatus play Nov 25 22:38:14 volumiopi volumio[865]: info: Received an update from plugin. extracting info from payload Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:14 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:14 volumiopi sudo[1634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:14 volumiopi sudo[1634]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:14 volumiopi sudo[1634]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:14 volumiopi volumio[865]: info: ------------------------------ 82ms Nov 25 22:38:15 volumiopi sudo[1641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:15 volumiopi sudo[1641]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:15 volumiopi sudo[1641]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:18 volumiopi volumio[865]: info: CoreCommandRouter::volumioGetQueue Nov 25 22:38:18 volumiopi volumio[865]: info: CoreStateMachine::getQueue Nov 25 22:38:18 volumiopi volumio[865]: info: CorePlayQueue::getQueue Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:18 volumiopi volumio[865]: info: No input data Nov 25 22:38:19 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: tunein_radio , handleBrowseUri Nov 25 22:38:19 volumiopi volumio[865]: info: TuneIn handleBrowseUri: tunein Nov 25 22:38:19 volumiopi volumio[865]: info: [TuneIn] Added new entry local => Local Radio Nov 25 22:38:19 volumiopi volumio[865]: info: [TuneIn] Added new entry music => Music Nov 25 22:38:19 volumiopi volumio[865]: info: [TuneIn] Added new entry talk => Talk Nov 25 22:38:19 volumiopi volumio[865]: info: [TuneIn] Added new entry sports => Sports Nov 25 22:38:19 volumiopi volumio[865]: info: [TuneIn] Added new entry location => By Location Nov 25 22:38:19 volumiopi volumio[865]: info: [TuneIn] Added new entry language => By Language Nov 25 22:38:26 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:27 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:29 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:31 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:32 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:32 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:32 volumiopi volumio[865]: info: Getting webradio selection Nov 25 22:38:33 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:34 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:36 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 25 22:38:37 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Nov 25 22:38:37 volumiopi volumio[865]: info: [1732574317917] [80s80s] handleBrowseUri curUri: 80s80s Nov 25 22:38:39 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Nov 25 22:38:39 volumiopi volumio[865]: info: [1732574319714] [80s80s] handleBrowseUri curUri: 80s80s/eighties Nov 25 22:38:39 volumiopi volumio[865]: info: [1732574319716] [80s80s] getRadioContent url: eighties Nov 25 22:38:40 volumiopi volumio[865]: info: CoreCommandRouter::volumioAddQueueItems Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::addQueueItems Nov 25 22:38:40 volumiopi volumio[865]: info: CorePlayQueue::addQueueItems Nov 25 22:38:40 volumiopi volumio[865]: info: Adding Item to queue: webeighties/0 Nov 25 22:38:40 volumiopi volumio[865]: info: Exploding uri webeighties/0 in service 80s80s Nov 25 22:38:40 volumiopi volumio[865]: info: [1732574320914] [80s80s] explodeUri: webeighties/0 Nov 25 22:38:40 volumiopi volumio[865]: info: CorePlayQueue::saveQueue Nov 25 22:38:40 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushQueue Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::updateTrackBlock Nov 25 22:38:40 volumiopi volumio[865]: info: CorePlayQueue::getTrackBlock Nov 25 22:38:40 volumiopi volumio[865]: info: CoreCommandRouter::volumioPlay Nov 25 22:38:40 volumiopi volumio[865]: UNSET VOLATILE Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::play index 5 Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::stop Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 22:38:40 volumiopi volumio[865]: UNSET VOLATILE Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::stPlaybackTimer Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::updateTrackBlock Nov 25 22:38:40 volumiopi volumio[865]: info: CorePlayQueue::getTrackBlock Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:40 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:40 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:40 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:40 volumiopi volumio[865]: info: CoreStateMachine::serviceStop Nov 25 22:38:40 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:40 volumiopi volumio[865]: info: CoreCommandRouter::serviceStop Nov 25 22:38:40 volumiopi volumio[865]: info: [1732574320956] ControllerWebradio::stop Nov 25 22:38:40 volumiopi sudo[1834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:40 volumiopi sudo[1834]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:40 volumiopi sudo[1834]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:40 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand stop Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: Nov 25 22:38:41 volumiopi volumio[865]: ---------------------------- MPD announces state update: player Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::getState Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand status Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::play index undefined Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::startPlaybackTimer Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: [1732574321069] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/web/mp3-192/streams.80s80s.de Nov 25 22:38:41 volumiopi volumio[865]: info: [1732574321071] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=2 Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::parseState Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand playlistinfo Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::parseTrackInfo Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::pushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreCommandRouter::servicePushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::syncState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 25 22:38:41 volumiopi volumio[865]: info: ------------------------------ 49ms Nov 25 22:38:41 volumiopi sudo[1843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:41 volumiopi sudo[1843]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:41 volumiopi sudo[1843]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:41 volumiopi volumio[865]: info: No input data Nov 25 22:38:41 volumiopi volumio[865]: info: [1732574321520] [80s80s] received new event containing 2 songs. Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand stop Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand clear Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: Nov 25 22:38:41 volumiopi volumio[865]: ---------------------------- MPD announces system playlist update Nov 25 22:38:41 volumiopi volumio[865]: info: Ignoring MPD Status Update Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: [1732574321529] [80s80s] adding url: http://streams.80s80s.de/web/mp3-192/streams.80s80s.de Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/streams.80s80s.de" Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: Nov 25 22:38:41 volumiopi volumio[865]: info: Nov 25 22:38:41 volumiopi volumio[865]: ---------------------------- MPD announces system playlist update Nov 25 22:38:41 volumiopi volumio[865]: info: Ignoring MPD Status Update Nov 25 22:38:41 volumiopi volumio[865]: info: ------------------------------ 6ms Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: ControllerMpd::sendMpdCommand play Nov 25 22:38:41 volumiopi volumio[865]: info: sending command... Nov 25 22:38:41 volumiopi volumio[865]: info: ------------------------------ 8ms Nov 25 22:38:41 volumiopi volumio[865]: info: parsing response... Nov 25 22:38:41 volumiopi volumio[865]: info: [1732574321542] [80s80s] Pushing the next song state: Johnny Hates Jazz - Turn Back the Clock Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: CoreCommandRouter::servicePushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::syncState Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is4-ssl.mzstatic.com/image/thumb/Music114/v4/1f/e9/f1/1fe9f141-378f-ee04-df3d-d2034539b227/source/600x600bb.jpg","name":"Johnny Hates Jazz - Turn Back the Clock","title":"Turn Back the Clock","artist":"80s80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"254","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 25 22:38:41 volumiopi volumio[865]: info: CURRENT POSITION 5 Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::syncState stateService play Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::syncState currentStatus stop Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::pushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreStateMachine::getState Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: CoreCommandRouter::volumioPushState Nov 25 22:38:41 volumiopi volumio[865]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 22:38:41 volumiopi volumio[865]: info: [1732574321575] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json Nov 25 22:38:41 volumiopi sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 5 Nov 25 22:38:41 volumiopi volumio[865]: info: CorePlayQueue::getTrack 0 Nov 25 22:38:41 volumiopi sudo[1853]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 22:38:41 volumiopi sudo[1853]: pam_unix(sudo:session): session closed for user root Nov 25 22:38:42 volumiopi volumio[865]: info: [1732574322480] [80s80s] Failed to query api, status code: 404 Nov 25 22:38:42 volumiopi volumio[865]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 22:38:42 volumiopi volumio[865]: ReferenceError: station is not defined Nov 25 22:38:42 volumiopi volumio[865]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) Nov 25 22:38:42 volumiopi volumio[865]: at Object.onceWrapper (events.js:315:30) Nov 25 22:38:42 volumiopi volumio[865]: at emitOne (events.js:116:13) Nov 25 22:38:42 volumiopi volumio[865]: at ClientRequest.emit (events.js:211:7) Nov 25 22:38:42 volumiopi volumio[865]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Nov 25 22:38:42 volumiopi volumio[865]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Nov 25 22:38:42 volumiopi volumio[865]: at Socket.socketOnData (_http_client.js:440:20) Nov 25 22:38:42 volumiopi volumio[865]: at emitOne (events.js:116:13) Nov 25 22:38:42 volumiopi volumio[865]: at Socket.emit (events.js:211:7) Nov 25 22:38:42 volumiopi volumio[865]: at addChunk (_stream_readable.js:263:12) Nov 25 22:38:42 volumiopi volumio[865]: at readableAddChunk (_stream_readable.js:250:11) Nov 25 22:38:42 volumiopi volumio[865]: at Socket.Readable.push (_stream_readable.js:208:10) Nov 25 22:38:42 volumiopi volumio[865]: at TCP.onread (net.js:607:20) Nov 25 22:38:42 volumiopi volumio[865]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 22:38:43 volumiopi sudo[1877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 22:37 Nov 25 22:38:43 volumiopi sudo[1877]: 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="fe83e03fe4a5ad6387f0fd162f915b7fc3065a36" VOLUMIO_FE_VERSION="3927cf879718a0297ddabc3805589c385dd4c7bd" VOLUMIO_BE_VERSION="d57008595633b428eec7784fea777242fe1c15ac" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Apr 23 20:16:23 CEST 2019" VOLUMIO_VERSION="2.575" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5b62cf8f91d8d86f894459ee8b534ab5"