-- Logs begin at Wed 2024-06-26 16:39:22 UTC, end at Sun 2024-07-21 15:10:07 UTC. -- Jul 21 15:09:00 volumio1 volumio[889]: info: ControllerPodcast::constructor Jul 21 15:09:00 volumio1 volumio[889]: info: ___________ START PLUGINS ___________ Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 15:09:00 volumio1 volumio[889]: info: [1721574540705] CoreMusicLibrary::Adding element Last_100 Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 15:09:00 volumio1 volumio[889]: info: [1721574540725] CoreMusicLibrary::Adding element Webradio Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 15:09:00 volumio1 volumio[889]: info: [1721574540768] CoreMusicLibrary::Adding element Podcast Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 15:09:00 volumio1 volumio[889]: info: ------------------------------------------- Jul 21 15:09:00 volumio1 volumio[889]: info: ----- MyVolumio plugins startup ---- Jul 21 15:09:00 volumio1 volumio[889]: info: ------------------------------------------- Jul 21 15:09:00 volumio1 volumio[889]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 21 15:09:00 volumio1 volumio[889]: info: Loading i18n strings for locale de Jul 21 15:09:00 volumio1 volumio[889]: Updating browse sources language Jul 21 15:09:00 volumio1 volumio[889]: Cannot find translation for sourcePodcast Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::initPlayerControls Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:00 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 15:09:01 volumio1 volumio[889]: info: BOOT COMPLETED Jul 21 15:09:01 volumio1 volumio[889]: [Metrics] CommandRouter: 17s 367.83ms Jul 21 15:09:01 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 15:09:01 volumio1 volumio-remote-updater[703]: [2024-07-21 15:09:01] [connect] Successful connection Jul 21 15:09:05 volumio1 sudo[988]: pam_unix(sudo:session): session closed for user root Jul 21 15:09:05 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:09:05 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:09:06 volumio1 volumio[889]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 21 15:09:06 volumio1 volumio[889]: info: CoreCommandRouter::Close All Modals sent Jul 21 15:09:06 volumio1 volumio[889]: info: CoreCommandRouter::Close All Modals sent Jul 21 15:09:06 volumio1 volumio[889]: Express server listening on port 3000 Jul 21 15:09:06 volumio1 volumio[889]: [Metrics] WebUI: 24s 61.95ms Jul 21 15:09:06 volumio1 volumio[889]: Volumio Calling Home Jul 21 15:09:06 volumio1 volumio[889]: info: CoreStateMachine::resetVolumioState Jul 21 15:09:06 volumio1 volumio[889]: info: CoreStateMachine::getcurrentVolume Jul 21 15:09:06 volumio1 volumio[889]: info: CoreCommandRouter::volumioRetrievevolume Jul 21 15:09:06 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 15:09:06 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 15:09:07 volumio1 volumio[889]: info: Volumio called home Jul 21 15:09:07 volumio1 volumio[889]: info: Setting Device type: Raspberry PI Jul 21 15:09:07 volumio1 volumio[889]: info: Cannot mount NAS MUSIK at system boot, trial number 1 ,retrying in 5 seconds Jul 21 15:09:07 volumio1 volumio[889]: info: MPD running with PID750 Jul 21 15:09:07 volumio1 volumio[889]: ,establishing connection Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 21 15:09:07 volumio1 volumio[889]: info: Jul 21 15:09:07 volumio1 volumio[889]: ---------------------------- Client requests Volume 60 Jul 21 15:09:07 volumio1 volumio[889]: info: VolumeController::SetAlsaVolume60 Jul 21 15:09:07 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:07 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:07 volumio1 volumio[889]: info: VolumeController:: Volume=75 Mute =false Jul 21 15:09:07 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:07 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:07 volumio1 volumio[889]: info: CoreStateMachine::updateTrackBlock Jul 21 15:09:07 volumio1 volumio[889]: info: CorePlayQueue::getTrackBlock Jul 21 15:09:07 volumio1 volumio[889]: info: CoreCommandRouter::volumioRetrievevolume Jul 21 15:09:07 volumio1 volumio[889]: info: Reloading queue from file Jul 21 15:09:07 volumio1 volumio[889]: error: updateQueue error: null Jul 21 15:09:08 volumio1 volumio[889]: info: Setting volume on startup at 60 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreStateMachine::setRepeat true single undefined Jul 21 15:09:08 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:08 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:08 volumio1 volumio[889]: info: CoreStateMachine::setRandom false Jul 21 15:09:08 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:08 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:08 volumio1 volumio[889]: info: VolumeController:: Volume=60 Mute =false Jul 21 15:09:08 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:08 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:08 volumio1 volumio[889]: Discovery: adding d0a25f80-56cd-441e-a5e5-0672b954995e Jul 21 15:09:08 volumio1 volumio[889]: info: mDNS: Found device Volumio1 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 15:09:08 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:08 volumio1 volumio[889]: Discovery: this is already registered, d0a25f80-56cd-441e-a5e5-0672b954995e Jul 21 15:09:08 volumio1 volumio[889]: info: mDNS: Found device Volumio4 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 15:09:08 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:08 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 15:09:08 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 21 15:09:12 volumio1 sudo[1118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //VOLUMIOPI4/USB\AHATTERMANN\MUSIK /mnt/NAS/MUSIK Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 21 15:09:12 volumio1 volumio[889]: info: Adding plugin bluetooth to MyMusic Plugins Jul 21 15:09:12 volumio1 volumio[889]: info: Adding plugin cd_controller to MyMusic Plugins Jul 21 15:09:12 volumio1 sudo[1118]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 15:09:12 volumio1 volumio[889]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 21 15:09:12 volumio1 volumio[889]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 21 15:09:12 volumio1 volumio[889]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 21 15:09:12 volumio1 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 21 15:09:14 volumio1 volumio[889]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 21 15:09:14 volumio1 volumio[889]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 21 15:09:14 volumio1 volumio[889]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 21 15:09:14 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 15:09:14 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 15:09:14 volumio1 volumio[889]: info: Starting MyVolumio Remote Streaming Endpoints Jul 21 15:09:14 volumio1 volumio[889]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 21 15:09:14 volumio1 volumio[889]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 21 15:09:14 volumio1 volumio[889]: info: Streaming services startup Jul 21 15:09:14 volumio1 volumio[889]: info: Starting Streaming Daemon Jul 21 15:09:14 volumio1 sudo[1126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 21 15:09:14 volumio1 sudo[1126]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 15:09:14 volumio1 volumio[889]: info: MyVolumio not started Jul 21 15:09:14 volumio1 volumio[889]: info: Initializing device activation check Jul 21 15:09:14 volumio1 systemd[1]: Stopping Volumio Streaming Daemon... Jul 21 15:09:14 volumio1 volumio[889]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 21 15:09:14 volumio1 systemd[1]: Starting Volumio Streaming Daemon... Jul 21 15:09:14 volumio1 systemd[1]: Started Volumio Streaming Daemon. Jul 21 15:09:15 volumio1 sudo[1126]: pam_unix(sudo:session): session closed for user root Jul 21 15:09:15 volumio1 volumio-streaming-daemon[1136]: ############################ Jul 21 15:09:15 volumio1 volumio-streaming-daemon[1136]: # Volumio Streaming Daemon # Jul 21 15:09:15 volumio1 volumio-streaming-daemon[1136]: # Running on port 7777 # Jul 21 15:09:15 volumio1 volumio-streaming-daemon[1136]: ############################ Jul 21 15:09:15 volumio1 volumio-streaming-daemon[1136]: Environment: production Jul 21 15:09:15 volumio1 volumio[889]: info: AutoStart - getting queue Jul 21 15:09:15 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetQueue Jul 21 15:09:15 volumio1 volumio[889]: info: CoreStateMachine::getQueue Jul 21 15:09:15 volumio1 volumio[889]: info: CorePlayQueue::getQueue Jul 21 15:09:15 volumio1 volumio[889]: info: AutoStart - start playing -> queue is not empty Jul 21 15:09:15 volumio1 volumio[889]: info: CoreCommandRouter::volumioPlay Jul 21 15:09:15 volumio1 volumio[889]: UNSET VOLATILE Jul 21 15:09:15 volumio1 volumio[889]: info: CoreStateMachine::play index undefined Jul 21 15:09:15 volumio1 volumio[889]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 21 15:09:15 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:15 volumio1 volumio[889]: info: CoreStateMachine::startPlaybackTimer Jul 21 15:09:15 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:15 volumio1 volumio[889]: info: [1721574555067] ControllerWebradio::clearAddPlayTrack Jul 21 15:09:15 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand stop Jul 21 15:09:15 volumio1 volumio[889]: info: sendMpdCommand stop took 24 milliseconds Jul 21 15:09:15 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand clear Jul 21 15:09:15 volumio1 volumio[889]: info: Jul 21 15:09:15 volumio1 volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 15:09:15 volumio1 volumio[889]: info: Ignoring MPD Status Update Jul 21 15:09:15 volumio1 volumio[889]: info: sendMpdCommand clear took 19 milliseconds Jul 21 15:09:15 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand load "https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein" Jul 21 15:09:15 volumio1 volumio[889]: error: updateQueue error: null Jul 21 15:09:15 volumio1 volumio[889]: info: ------------------------------ 16ms Jul 21 15:09:16 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand add "https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein" Jul 21 15:09:16 volumio1 volumio[889]: info: Jul 21 15:09:16 volumio1 volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 15:09:16 volumio1 volumio[889]: info: Ignoring MPD Status Update Jul 21 15:09:16 volumio1 volumio[889]: info: sendMpdCommand add "https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein" took 4 milliseconds Jul 21 15:09:16 volumio1 volumio[889]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 21 15:09:16 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand play Jul 21 15:09:16 volumio1 volumio[889]: info: ------------------------------ 10ms Jul 21 15:09:16 volumio1 volumio[889]: info: sendMpdCommand play took 5 milliseconds Jul 21 15:09:16 volumio1 volumio-remote-updater[703]: [2024-07-21 15:09:16] [connect] Successful connection Jul 21 15:09:16 volumio1 volumio-remote-updater[703]: [2024-07-21 15:09:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1721574556 101 Jul 21 15:09:17 volumio1 volumio[889]: info: Jul 21 15:09:17 volumio1 volumio[889]: ---------------------------- MPD announces state update: player Jul 21 15:09:17 volumio1 volumio[889]: info: ControllerMpd::getState Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 15:09:17 volumio1 volumio[889]: info: sendMpdCommand status took 17 milliseconds Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::parseState Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 15:09:17 volumio1 volumio[889]: info: Jul 21 15:09:17 volumio1 volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 15:09:17 volumio1 volumio[889]: info: Ignoring MPD Status Update Jul 21 15:09:17 volumio1 volumio[889]: info: Jul 21 15:09:17 volumio1 volumio[889]: ---------------------------- MPD announces state update: player Jul 21 15:09:17 volumio1 volumio[889]: info: ControllerMpd::getState Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 15:09:17 volumio1 volumio[889]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 15:09:17 volumio1 volumio[889]: info: ControllerMpd::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 15:09:17 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:17 volumio1 volumio[889]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream.mp3?aggregator=tunein","artist":"Deutschlandfunk","album":null,"uri":"https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein","trackType":""} Jul 21 15:09:17 volumio1 volumio[889]: verbose: CURRENT POSITION 0 Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::syncState stateService play Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::syncState currentStatus stop Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:17 volumio1 volumio[889]: info: ------------------------------ 71ms Jul 21 15:09:17 volumio1 volumio[889]: info: ------------------------------ 44ms Jul 21 15:09:17 volumio1 volumio[889]: info: sendMpdCommand status took 40 milliseconds Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::parseState Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 15:09:17 volumio1 volumio[889]: info: sendMpdCommand playlistinfo took 8 milliseconds Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 15:09:17 volumio1 volumio[889]: info: ControllerMpd::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 15:09:17 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:17 volumio1 volumio[889]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream.mp3?aggregator=tunein","artist":"Deutschlandfunk","album":null,"uri":"https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein","trackType":""} Jul 21 15:09:17 volumio1 volumio[889]: verbose: CURRENT POSITION 0 Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::syncState stateService play Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::syncState currentStatus play Jul 21 15:09:17 volumio1 volumio[889]: info: Received an update from plugin. extracting info from payload Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:17 volumio1 volumio[889]: info: ------------------------------ 86ms Jul 21 15:09:17 volumio1 volumio[889]: info: Jul 21 15:09:17 volumio1 volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 15:09:17 volumio1 volumio[889]: info: Ignoring MPD Status Update Jul 21 15:09:17 volumio1 volumio[889]: info: Jul 21 15:09:17 volumio1 volumio[889]: ---------------------------- MPD announces state update: player Jul 21 15:09:17 volumio1 volumio[889]: info: ControllerMpd::getState Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 15:09:17 volumio1 volumio[889]: info: ------------------------------ 15ms Jul 21 15:09:17 volumio1 volumio[889]: info: sendMpdCommand status took 11 milliseconds Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::parseState Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 15:09:17 volumio1 volumio[889]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 21 15:09:17 volumio1 volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 15:09:17 volumio1 volumio[889]: info: ControllerMpd::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 15:09:17 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:17 volumio1 volumio[889]: verbose: STATE SERVICE {"status":"play","position":0,"seek":736,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deutschlandfunk - Alles von Relevanz","artist":"Deutschlandfunk","album":null,"uri":"https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein","trackType":""} Jul 21 15:09:17 volumio1 volumio[889]: verbose: CURRENT POSITION 0 Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::syncState stateService play Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::syncState currentStatus play Jul 21 15:09:17 volumio1 volumio[889]: info: Received an update from plugin. extracting info from payload Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:17 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:17 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:17 volumio1 volumio[889]: info: ------------------------------ 61ms Jul 21 15:09:17 volumio1 volumio-streaming-daemon[1136]: Environment: production Jul 21 15:09:17 volumio1 volumio[889]: info: Fetching Streaming Services browse cache Jul 21 15:09:18 volumio1 volumio[889]: info: Jul 21 15:09:18 volumio1 volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 15:09:18 volumio1 volumio[889]: info: Ignoring MPD Status Update Jul 21 15:09:18 volumio1 volumio[889]: info: Jul 21 15:09:18 volumio1 volumio[889]: ---------------------------- MPD announces state update: player Jul 21 15:09:18 volumio1 volumio[889]: info: ControllerMpd::getState Jul 21 15:09:18 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 15:09:18 volumio1 volumio[889]: info: ------------------------------ 17ms Jul 21 15:09:18 volumio1 volumio[889]: info: sendMpdCommand status took 6 milliseconds Jul 21 15:09:18 volumio1 volumio[889]: verbose: ControllerMpd::parseState Jul 21 15:09:18 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 15:09:18 volumio1 volumio[889]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 21 15:09:18 volumio1 volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 15:09:18 volumio1 volumio[889]: info: ControllerMpd::pushState Jul 21 15:09:18 volumio1 volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 15:09:18 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:09:18 volumio1 volumio[889]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Joseph Hanimann über die Olympischen Spiele im Département Seine-Saint-Denis, Dirk Fuhrig & JosephHanimann","artist":"Deutschlandfunk","album":null,"uri":"https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein","trackType":""} Jul 21 15:09:18 volumio1 volumio[889]: verbose: CURRENT POSITION 0 Jul 21 15:09:18 volumio1 volumio[889]: info: CoreStateMachine::syncState stateService play Jul 21 15:09:18 volumio1 volumio[889]: info: CoreStateMachine::syncState currentStatus play Jul 21 15:09:18 volumio1 volumio[889]: info: Received an update from plugin. extracting info from payload Jul 21 15:09:18 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:18 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:18 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:18 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:09:18 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:09:18 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:09:18 volumio1 volumio[889]: info: ------------------------------ 48ms Jul 21 15:09:19 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:09:19 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:09:19 volumio1 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 21 15:09:25 volumio1 sudo[1118]: pam_unix(sudo:session): session closed for user root Jul 21 15:09:25 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:09:25 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:09:25 volumio1 volumio[889]: info: Cannot mount NAS MUSIK at system boot, trial number 2 ,retrying in 5 seconds Jul 21 15:09:30 volumio1 sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //VOLUMIOPI4/USB\AHATTERMANN\MUSIK /mnt/NAS/MUSIK Jul 21 15:09:30 volumio1 sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 15:09:30 volumio1 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 21 15:09:30 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 15:09:30 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 15:09:36 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:09:36 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:09:36 volumio1 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 21 15:09:37 volumio1 sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 21 15:09:37 volumio1 sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 15:09:37 volumio1 sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 15:09:37 volumio1 sudo[1181]: pam_unix(sudo:session): session closed for user root Jul 21 15:09:37 volumio1 sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 15:09:37 volumio1 sudo[1183]: pam_unix(sudo:session): session closed for user root Jul 21 15:09:38 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetState Jul 21 15:09:38 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 21 15:09:38 volumio1 volumio[889]: info: Listing playlists Jul 21 15:09:38 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 21 15:09:38 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 21 15:09:38 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 21 15:09:38 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 21 15:09:39 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 21 15:09:43 volumio1 sudo[1154]: pam_unix(sudo:session): session closed for user root Jul 21 15:09:43 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:09:43 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:09:43 volumio1 volumio[889]: info: Cannot mount NAS MUSIK at system boot, trial number 3 ,retrying in 5 seconds Jul 21 15:09:48 volumio1 sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //VOLUMIOPI4/USB\AHATTERMANN\MUSIK /mnt/NAS/MUSIK Jul 21 15:09:48 volumio1 sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 15:09:48 volumio1 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 21 15:09:51 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 15:09:51 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 15:09:51 volumio1 volumio[889]: info: CoreCommandRouter::volumioGetQueue Jul 21 15:09:51 volumio1 volumio[889]: info: CoreStateMachine::getQueue Jul 21 15:09:51 volumio1 volumio[889]: info: CorePlayQueue::getQueue Jul 21 15:09:52 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jul 21 15:09:54 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:09:54 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:09:54 volumio1 kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 21 15:10:00 volumio1 sudo[1209]: pam_unix(sudo:session): session closed for user root Jul 21 15:10:00 volumio1 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Jul 21 15:10:00 volumio1 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Jul 21 15:10:00 volumio1 volumio[889]: info: Cannot mount NAS MUSIK at system boot, trial number 4 ,retrying in 5 seconds Jul 21 15:10:04 volumio1 volumio[889]: info: Jul 21 15:10:04 volumio1 volumio[889]: ---------------------------- MPD announces system playlist update Jul 21 15:10:04 volumio1 volumio[889]: info: Ignoring MPD Status Update Jul 21 15:10:04 volumio1 volumio[889]: info: Jul 21 15:10:04 volumio1 volumio[889]: ---------------------------- MPD announces state update: player Jul 21 15:10:04 volumio1 volumio[889]: info: ControllerMpd::getState Jul 21 15:10:04 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand status Jul 21 15:10:04 volumio1 volumio[889]: info: ------------------------------ 6ms Jul 21 15:10:04 volumio1 volumio[889]: info: sendMpdCommand status took 4 milliseconds Jul 21 15:10:04 volumio1 volumio[889]: verbose: ControllerMpd::parseState Jul 21 15:10:04 volumio1 volumio[889]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 21 15:10:04 volumio1 volumio[889]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 21 15:10:04 volumio1 volumio[889]: verbose: ControllerMpd::parseTrackInfo Jul 21 15:10:04 volumio1 volumio[889]: info: ControllerMpd::pushState Jul 21 15:10:04 volumio1 volumio[889]: info: CoreCommandRouter::servicePushState Jul 21 15:10:04 volumio1 volumio[889]: info: CorePlayQueue::getTrack 0 Jul 21 15:10:04 volumio1 volumio[889]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47485,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Kulturfragen mit Dirk Fuhrig","artist":"Deutschlandfunk","album":null,"uri":"https://st01.sslstream.dlf.de/dlf/01/128/mp3/stream.mp3?aggregator=tunein","trackType":""} Jul 21 15:10:04 volumio1 volumio[889]: verbose: CURRENT POSITION 0 Jul 21 15:10:04 volumio1 volumio[889]: info: CoreStateMachine::syncState stateService play Jul 21 15:10:04 volumio1 volumio[889]: info: CoreStateMachine::syncState currentStatus play Jul 21 15:10:04 volumio1 volumio[889]: info: Received an update from plugin. extracting info from payload Jul 21 15:10:04 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:10:04 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:10:04 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:10:04 volumio1 volumio[889]: info: CoreStateMachine::pushState Jul 21 15:10:04 volumio1 volumio[889]: info: CoreCommandRouter::volumioPushState Jul 21 15:10:04 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 15:10:04 volumio1 volumio[889]: info: ------------------------------ 39ms Jul 21 15:10:05 volumio1 volumio[889]: info: CoreCommandRouter::executeOnPlugin: podcast , handleBrowseUri Jul 21 15:10:05 volumio1 volumio[889]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 15:10:05 volumio1 volumio[889]: TypeError: Cannot read property 'title' of undefined Jul 21 15:10:05 volumio1 volumio[889]: at /data/plugins/music_service/podcast/index.js:421:51 Jul 21 15:10:05 volumio1 volumio[889]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/podcast/node_modules/rss-parser/lib/utils.js:63:29) Jul 21 15:10:05 volumio1 volumio[889]: at ontimeout (timers.js:482:11) Jul 21 15:10:05 volumio1 volumio[889]: at tryOnTimeout (timers.js:317:5) Jul 21 15:10:05 volumio1 volumio[889]: at Timer.listOnTimeout (timers.js:277:5) Jul 21 15:10:05 volumio1 volumio[889]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 15:10:07 volumio1 sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 15:09 Jul 21 15:10:07 volumio1 sudo[1227]: 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="14acf028cf46278bd3fd3dd02523424a9bc825bf" VOLUMIO_FE_VERSION="74f64fbba9dc8053dc27ed7125863d6ad6533965" VOLUMIO_BE_VERSION="0a6008ded215bf284d5d4cd9c4df3333cb320899" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Apr 24 17:39:58 CEST 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="1a98a01eef5aa5927a5874c2d3c1b0dc"