-- 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"