-- Logs begin at Thu 2024-11-21 14:45:58 +07, end at Thu 2024-11-21 14:50:21 +07. -- Nov 21 14:49:00 music-server volumio[1175]: 0+0 records in Nov 21 14:49:00 music-server volumio[1175]: 0+0 records out Nov 21 14:49:00 music-server volumio[1175]: 0 bytes copied, 5.4774e-05 s, 0.0 kB/s Nov 21 14:49:00 music-server volumio[1175]: info: camilladsp spawned new process with pid 3694, instance 1, run: true Nov 21 14:49:00 music-server volumiologrotate[677]: ls: cannot access '/var/log/samba/log.wb-MUSIC': No such file or directory Nov 21 14:49:00 music-server volumiologrotate[677]: ls: cannot access 'SERVER': No such file or directory Nov 21 14:49:01 music-server volumio[1175]: 0+0 records in Nov 21 14:49:01 music-server volumio[1175]: 0+0 records out Nov 21 14:49:01 music-server volumio[1175]: 0 bytes copied, 5.9952e-05 s, 0.0 kB/s Nov 21 14:49:01 music-server volumio[1175]: info: camilladsp spawned new process with pid 3746, instance 1, run: true Nov 21 14:49:02 music-server volumio[1175]: 0+0 records in Nov 21 14:49:02 music-server volumio[1175]: 0+0 records out Nov 21 14:49:02 music-server volumio[1175]: 0 bytes copied, 7.1764e-05 s, 0.0 kB/s Nov 21 14:49:02 music-server volumio[1175]: info: camilladsp spawned new process with pid 3751, instance 1, run: true Nov 21 14:49:03 music-server volumio[1175]: 0+0 records in Nov 21 14:49:03 music-server volumio[1175]: 0+0 records out Nov 21 14:49:03 music-server volumio[1175]: 0 bytes copied, 5.8097e-05 s, 0.0 kB/s Nov 21 14:49:03 music-server volumio[1175]: info: camilladsp spawned new process with pid 3759, instance 1, run: true Nov 21 14:49:03 music-server volumio[1175]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 21 14:49:03 music-server volumio[1175]: info: Preparing to save Alsa Options, stopping services first Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:03 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::volumioPause Nov 21 14:49:03 music-server volumio[1175]: info: CoreStateMachine::pause Nov 21 14:49:03 music-server volumio[1175]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"iFi (by AMR) HD USB Audio"}} Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 21 14:49:03 music-server volumio[1175]: info: Setting mixer iFi (by AMR) HD USB Audio for card iFi (by AMR) HD USB Audio Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 21 14:49:03 music-server volumio[1175]: info: Updating Volume Controller Parameters: Device: 5 Name: iFi (by AMR) HD USB Audio Mixer: iFi (by AMR) HD USB Audio Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 21 14:49:03 music-server volumio[1175]: info: Disabling external Volume Control Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:03 music-server volumio[1175]: info: Preparing to generate the ALSA configuration file Nov 21 14:49:03 music-server volumio[1175]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 21 14:49:03 music-server volumio[1175]: info: Reading ALSA contributions from plugins. Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 21 14:49:03 music-server volumio[1175]: info: VolumeController:: Volume=50 Mute =false Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:03 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:03 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:03 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:03 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:03 music-server volumio[1175]: info: Asound.conf file unchanged, so no further update is needed Nov 21 14:49:03 music-server volumio[1175]: info: Output device has changed, restarting MPD Nov 21 14:49:03 music-server sudo[3777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 21 14:49:03 music-server sudo[3777]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:49:03 music-server sudo[3777]: pam_unix(sudo:session): session closed for user root Nov 21 14:49:03 music-server volumio[1175]: info: Output device has changed, restarting Shairport Sync Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 14:49:03 music-server sudo[3780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 21 14:49:03 music-server sudo[3780]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:49:03 music-server systemd[1]: Stopping Music Player Daemon... Nov 21 14:49:03 music-server volumio[1175]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 21 14:49:03 music-server volumio[1175]: info: MPD Permissions set Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 21 14:49:03 music-server volumio[1175]: info: Starting Shairport Sync Nov 21 14:49:03 music-server sudo[3792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 21 14:49:03 music-server sudo[3792]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:49:03 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:03 music-server systemd[1]: mpd.service: Succeeded. Nov 21 14:49:03 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:03 music-server systemd[1]: Stopped Music Player Daemon. Nov 21 14:49:03 music-server systemd[1]: Starting Music Player Daemon... Nov 21 14:49:03 music-server systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 21 14:49:03 music-server systemd[1]: shairport-sync.service: Succeeded. Nov 21 14:49:03 music-server systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 21 14:49:03 music-server systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 21 14:49:03 music-server sudo[3792]: pam_unix(sudo:session): session closed for user root Nov 21 14:49:03 music-server volumio[1175]: info: Shairport-Sync Started Nov 21 14:49:03 music-server sudo[3794]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 21 14:49:03 music-server sudo[3794]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:49:03 music-server sudo[3794]: pam_unix(sudo:session): session closed for user root Nov 21 14:49:04 music-server volumio[1175]: 0+0 records in Nov 21 14:49:04 music-server volumio[1175]: 0+0 records out Nov 21 14:49:04 music-server volumio[1175]: 0 bytes copied, 0.000130925 s, 0.0 kB/s Nov 21 14:49:04 music-server volumio[1175]: info: camilladsp spawned new process with pid 3802, instance 1, run: true Nov 21 14:49:04 music-server mpd[3799]: Nov 21 07:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 21 14:49:04 music-server systemd[1]: Started Music Player Daemon. Nov 21 14:49:04 music-server sudo[3780]: pam_unix(sudo:session): session closed for user root Nov 21 14:49:04 music-server volumio[1175]: error: updateQueue error: null Nov 21 14:49:05 music-server volumio[1175]: 0+0 records in Nov 21 14:49:05 music-server volumio[1175]: 0+0 records out Nov 21 14:49:05 music-server volumio[1175]: 0 bytes copied, 5.5983e-05 s, 0.0 kB/s Nov 21 14:49:05 music-server volumio[1175]: info: camilladsp spawned new process with pid 3809, instance 1, run: true Nov 21 14:49:06 music-server systemd[1]: systemd-timedated.service: Succeeded. Nov 21 14:49:06 music-server volumio[1175]: 0+0 records in Nov 21 14:49:06 music-server volumio[1175]: 0+0 records out Nov 21 14:49:06 music-server volumio[1175]: 0 bytes copied, 6.6689e-05 s, 0.0 kB/s Nov 21 14:49:06 music-server volumio[1175]: info: camilladsp spawned new process with pid 3816, instance 1, run: true Nov 21 14:49:07 music-server volumio[1175]: 0+0 records in Nov 21 14:49:07 music-server volumio[1175]: 0+0 records out Nov 21 14:49:07 music-server volumio[1175]: 0 bytes copied, 6.259e-05 s, 0.0 kB/s Nov 21 14:49:07 music-server volumio[1175]: info: camilladsp spawned new process with pid 3821, instance 1, run: true Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 21 14:49:07 music-server volumio[1175]: info: CoreStateMachine::getcurrentVolume Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioRetrievevolume Nov 21 14:49:07 music-server volumio[1175]: info: VolumeController:: Volume=50 Mute =false Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:07 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:07 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:07 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:07 music-server volumio[1175]: info: CoreStateMachine::updateTrackBlock Nov 21 14:49:07 music-server volumio[1175]: info: CorePlayQueue::getTrackBlock Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioRetrievevolume Nov 21 14:49:07 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:07 music-server volumio[1175]: info: VolumeController:: Volume=50 Mute =false Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:07 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:07 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:07 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:07 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:07 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:08 music-server volumio[1175]: 0+0 records in Nov 21 14:49:08 music-server volumio[1175]: 0+0 records out Nov 21 14:49:08 music-server volumio[1175]: 0 bytes copied, 5.7369e-05 s, 0.0 kB/s Nov 21 14:49:08 music-server volumio[1175]: info: camilladsp spawned new process with pid 3844, instance 1, run: true Nov 21 14:49:09 music-server volumio[1175]: 0+0 records in Nov 21 14:49:09 music-server volumio[1175]: 0+0 records out Nov 21 14:49:09 music-server volumio[1175]: 0 bytes copied, 5.845e-05 s, 0.0 kB/s Nov 21 14:49:09 music-server volumio[1175]: info: camilladsp spawned new process with pid 3849, instance 1, run: true Nov 21 14:49:10 music-server volumio[1175]: 0+0 records in Nov 21 14:49:10 music-server volumio[1175]: 0+0 records out Nov 21 14:49:10 music-server volumio[1175]: 0 bytes copied, 5.5042e-05 s, 0.0 kB/s Nov 21 14:49:10 music-server volumio[1175]: info: camilladsp spawned new process with pid 3854, instance 1, run: true Nov 21 14:49:11 music-server volumio[1175]: 0+0 records in Nov 21 14:49:11 music-server volumio[1175]: 0+0 records out Nov 21 14:49:11 music-server volumio[1175]: 0 bytes copied, 7.6286e-05 s, 0.0 kB/s Nov 21 14:49:11 music-server volumio[1175]: info: camilladsp spawned new process with pid 3859, instance 1, run: true Nov 21 14:49:12 music-server volumio[1175]: 0+0 records in Nov 21 14:49:12 music-server volumio[1175]: 0+0 records out Nov 21 14:49:12 music-server volumio[1175]: 0 bytes copied, 5.8512e-05 s, 0.0 kB/s Nov 21 14:49:12 music-server volumio[1175]: info: camilladsp spawned new process with pid 3864, instance 1, run: true Nov 21 14:49:13 music-server volumio[1175]: 0+0 records in Nov 21 14:49:13 music-server volumio[1175]: 0+0 records out Nov 21 14:49:13 music-server volumio[1175]: 0 bytes copied, 5.6819e-05 s, 0.0 kB/s Nov 21 14:49:13 music-server volumio[1175]: info: camilladsp spawned new process with pid 3872, instance 1, run: true Nov 21 14:49:14 music-server volumio[1175]: info: CoreCommandRouter::volumioPlay Nov 21 14:49:14 music-server volumio[1175]: info: CoreStateMachine::play index undefined Nov 21 14:49:14 music-server volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 14:49:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:14 music-server volumio[1175]: info: CoreStateMachine::startPlaybackTimer Nov 21 14:49:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:14 music-server volumio[1175]: info: ControllerMpd::resume Nov 21 14:49:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand play Nov 21 14:49:14 music-server volumio[1175]: info: sendMpdCommand play took 0 milliseconds Nov 21 14:49:14 music-server volumio[1175]: 0+0 records in Nov 21 14:49:14 music-server volumio[1175]: 0+0 records out Nov 21 14:49:14 music-server volumio[1175]: 0 bytes copied, 5.5349e-05 s, 0.0 kB/s Nov 21 14:49:14 music-server volumio[1175]: info: camilladsp spawned new process with pid 3877, instance 1, run: true Nov 21 14:49:15 music-server volumio[1175]: 0+0 records in Nov 21 14:49:15 music-server volumio[1175]: 0+0 records out Nov 21 14:49:15 music-server volumio[1175]: 0 bytes copied, 0.000125908 s, 0.0 kB/s Nov 21 14:49:15 music-server volumio[1175]: info: camilladsp spawned new process with pid 3882, instance 1, run: true Nov 21 14:49:16 music-server volumio[1175]: 0+0 records in Nov 21 14:49:16 music-server volumio[1175]: 0+0 records out Nov 21 14:49:16 music-server volumio[1175]: 0 bytes copied, 5.1482e-05 s, 0.0 kB/s Nov 21 14:49:16 music-server volumio[1175]: info: camilladsp spawned new process with pid 3888, instance 1, run: true Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:17 music-server volumio[1175]: info: Retrieving Cloud Streaming UI Nov 21 14:49:17 music-server volumio[1175]: info: Getting Tidal Cloud Configuration Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:17 music-server volumio[1175]: info: Getting Qobuz Cloud Configuration Nov 21 14:49:17 music-server volumio[1175]: info: Asking plugin for UI Config Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:17 music-server volumio[1175]: info: Getting Spotify Cloud Configuration Nov 21 14:49:17 music-server volumio[1175]: info: Asking plugin for UI Config Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:17 music-server volumio[1175]: info: Saving Spotify Acccount Nov 21 14:49:17 music-server volumio[1175]: info: Got Tidal Cloud Configuration Nov 21 14:49:17 music-server volumio[1175]: info: Got it Nov 21 14:49:17 music-server volumio[1175]: info: Got it Nov 21 14:49:17 music-server volumio[1175]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:49:17 music-server volumio[1175]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::volumioGetBrowseSources Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::volumioGetBrowseSources Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::volumioGetBrowseSources Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 14:49:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 21 14:49:17 music-server volumio[1175]: 0+0 records in Nov 21 14:49:17 music-server volumio[1175]: 0+0 records out Nov 21 14:49:17 music-server volumio[1175]: 0 bytes copied, 6.527e-05 s, 0.0 kB/s Nov 21 14:49:17 music-server volumio[1175]: info: camilladsp spawned new process with pid 3893, instance 1, run: true Nov 21 14:49:18 music-server volumio[1175]: 0+0 records in Nov 21 14:49:18 music-server volumio[1175]: 0+0 records out Nov 21 14:49:18 music-server volumio[1175]: 0 bytes copied, 6.4104e-05 s, 0.0 kB/s Nov 21 14:49:18 music-server volumio[1175]: info: camilladsp spawned new process with pid 3913, instance 1, run: true Nov 21 14:49:19 music-server volumio[1175]: 0+0 records in Nov 21 14:49:19 music-server volumio[1175]: 0+0 records out Nov 21 14:49:19 music-server volumio[1175]: 0 bytes copied, 5.4599e-05 s, 0.0 kB/s Nov 21 14:49:19 music-server volumio[1175]: info: camilladsp spawned new process with pid 3918, instance 1, run: true Nov 21 14:49:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 21 14:49:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 21 14:49:20 music-server volumio[1175]: 0+0 records in Nov 21 14:49:20 music-server volumio[1175]: 0+0 records out Nov 21 14:49:20 music-server volumio[1175]: 0 bytes copied, 5.5636e-05 s, 0.0 kB/s Nov 21 14:49:20 music-server volumio[1175]: info: camilladsp spawned new process with pid 3926, instance 1, run: true Nov 21 14:49:21 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 14:49:21 music-server volumio[1175]: 0+0 records in Nov 21 14:49:21 music-server volumio[1175]: 0+0 records out Nov 21 14:49:21 music-server volumio[1175]: 0 bytes copied, 7.2684e-05 s, 0.0 kB/s Nov 21 14:49:21 music-server volumio[1175]: info: camilladsp spawned new process with pid 3931, instance 1, run: true Nov 21 14:49:22 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 21 14:49:22 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand rescan Nov 21 14:49:22 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:49:22 music-server volumio[1175]: info: Nov 21 14:49:22 music-server volumio[1175]: ---------------------------- MPD announces state update: update Nov 21 14:49:22 music-server volumio[1175]: info: sendMpdCommand rescan took 2 milliseconds Nov 21 14:49:22 music-server volumio[1175]: info: ControllerMpd::getState Nov 21 14:49:22 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:49:22 music-server volumio[1175]: info: sendMpdCommand status took 2 milliseconds Nov 21 14:49:22 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:49:22 music-server volumio[1175]: info: Command Router : Notfying DB Updatetrue Nov 21 14:49:22 music-server volumio[1175]: info: CoreCommandRouter::Close All Modals sent Nov 21 14:49:22 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:49:22 music-server volumio[1175]: info: ControllerMpd::pushState Nov 21 14:49:22 music-server volumio[1175]: info: CoreCommandRouter::servicePushState Nov 21 14:49:22 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:22 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:22 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:49:22 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:22 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:22 music-server volumio[1175]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 21 14:49:22 music-server volumio[1175]: verbose: CURRENT POSITION 0 Nov 21 14:49:22 music-server volumio[1175]: info: CoreStateMachine::syncState stateService stop Nov 21 14:49:22 music-server volumio[1175]: info: CoreStateMachine::syncState currentStatus pause Nov 21 14:49:22 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:22 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:22 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:22 music-server volumio[1175]: info: ------------------------------ 117ms Nov 21 14:49:22 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:22 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:22 music-server volumio[1175]: 0+0 records in Nov 21 14:49:22 music-server volumio[1175]: 0+0 records out Nov 21 14:49:22 music-server volumio[1175]: 0 bytes copied, 0.000127803 s, 0.0 kB/s Nov 21 14:49:22 music-server volumio[1175]: info: camilladsp spawned new process with pid 3939, instance 1, run: true Nov 21 14:49:23 music-server volumio[1175]: 0+0 records in Nov 21 14:49:23 music-server volumio[1175]: 0+0 records out Nov 21 14:49:23 music-server volumio[1175]: 0 bytes copied, 6.3277e-05 s, 0.0 kB/s Nov 21 14:49:23 music-server volumio[1175]: info: camilladsp spawned new process with pid 3947, instance 1, run: true Nov 21 14:49:24 music-server volumio[1175]: 0+0 records in Nov 21 14:49:24 music-server volumio[1175]: 0+0 records out Nov 21 14:49:24 music-server volumio[1175]: 0 bytes copied, 5.5411e-05 s, 0.0 kB/s Nov 21 14:49:24 music-server volumio[1175]: info: camilladsp spawned new process with pid 3952, instance 1, run: true Nov 21 14:49:25 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 14:49:25 music-server volumio[1175]: 0+0 records in Nov 21 14:49:25 music-server volumio[1175]: 0+0 records out Nov 21 14:49:25 music-server volumio[1175]: 0 bytes copied, 5.6527e-05 s, 0.0 kB/s Nov 21 14:49:25 music-server volumio[1175]: info: camilladsp spawned new process with pid 3957, instance 1, run: true Nov 21 14:49:26 music-server volumio[1175]: 0+0 records in Nov 21 14:49:26 music-server volumio[1175]: 0+0 records out Nov 21 14:49:26 music-server volumio[1175]: 0 bytes copied, 5.7828e-05 s, 0.0 kB/s Nov 21 14:49:26 music-server volumio[1175]: info: camilladsp spawned new process with pid 3962, instance 1, run: true Nov 21 14:49:27 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 21 14:49:27 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand update Nov 21 14:49:27 music-server volumio[1175]: info: sendMpdCommand update took 2 milliseconds Nov 21 14:49:27 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 14:49:27 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 14:49:27 music-server volumio[1175]: info: Discovery: Getting this device information Nov 21 14:49:27 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:27 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:27 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 14:49:27 music-server volumio[1175]: 0+0 records in Nov 21 14:49:27 music-server volumio[1175]: 0+0 records out Nov 21 14:49:27 music-server volumio[1175]: 0 bytes copied, 0.000132804 s, 0.0 kB/s Nov 21 14:49:28 music-server volumio[1175]: info: camilladsp spawned new process with pid 3967, instance 1, run: true Nov 21 14:49:29 music-server volumio[1175]: 0+0 records in Nov 21 14:49:29 music-server volumio[1175]: 0+0 records out Nov 21 14:49:29 music-server volumio[1175]: 0 bytes copied, 5.7607e-05 s, 0.0 kB/s Nov 21 14:49:29 music-server volumio[1175]: info: camilladsp spawned new process with pid 3986, instance 1, run: true Nov 21 14:49:29 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 14:49:30 music-server volumio[1175]: 0+0 records in Nov 21 14:49:30 music-server volumio[1175]: 0+0 records out Nov 21 14:49:30 music-server volumio[1175]: 0 bytes copied, 7.6017e-05 s, 0.0 kB/s Nov 21 14:49:30 music-server volumio[1175]: info: camilladsp spawned new process with pid 3991, instance 1, run: true Nov 21 14:49:31 music-server volumio[1175]: 0+0 records in Nov 21 14:49:31 music-server volumio[1175]: 0+0 records out Nov 21 14:49:31 music-server volumio[1175]: 0 bytes copied, 5.7961e-05 s, 0.0 kB/s Nov 21 14:49:31 music-server volumio[1175]: info: camilladsp spawned new process with pid 3996, instance 1, run: true Nov 21 14:49:32 music-server volumio[1175]: 0+0 records in Nov 21 14:49:32 music-server volumio[1175]: 0+0 records out Nov 21 14:49:32 music-server volumio[1175]: 0 bytes copied, 5.349e-05 s, 0.0 kB/s Nov 21 14:49:32 music-server volumio[1175]: info: camilladsp spawned new process with pid 4001, instance 1, run: true Nov 21 14:49:33 music-server volumio[1175]: 0+0 records in Nov 21 14:49:33 music-server volumio[1175]: 0+0 records out Nov 21 14:49:33 music-server volumio[1175]: 0 bytes copied, 5.8129e-05 s, 0.0 kB/s Nov 21 14:49:33 music-server volumio[1175]: info: camilladsp spawned new process with pid 4009, instance 1, run: true Nov 21 14:49:33 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 21 14:49:34 music-server volumio[1175]: 0+0 records in Nov 21 14:49:34 music-server volumio[1175]: 0+0 records out Nov 21 14:49:34 music-server volumio[1175]: 0 bytes copied, 0.000121593 s, 0.0 kB/s Nov 21 14:49:34 music-server volumio[1175]: info: camilladsp spawned new process with pid 4014, instance 1, run: true Nov 21 14:49:35 music-server volumio[1175]: 0+0 records in Nov 21 14:49:35 music-server volumio[1175]: 0+0 records out Nov 21 14:49:35 music-server volumio[1175]: 0 bytes copied, 5.4338e-05 s, 0.0 kB/s Nov 21 14:49:35 music-server volumio[1175]: info: camilladsp spawned new process with pid 4019, instance 1, run: true Nov 21 14:49:36 music-server volumio[1175]: 0+0 records in Nov 21 14:49:36 music-server volumio[1175]: 0+0 records out Nov 21 14:49:36 music-server volumio[1175]: 0 bytes copied, 5.7814e-05 s, 0.0 kB/s Nov 21 14:49:36 music-server volumio[1175]: info: camilladsp spawned new process with pid 4024, instance 1, run: true Nov 21 14:49:37 music-server volumio[1175]: 0+0 records in Nov 21 14:49:37 music-server volumio[1175]: 0+0 records out Nov 21 14:49:37 music-server volumio[1175]: 0 bytes copied, 0.000115129 s, 0.0 kB/s Nov 21 14:49:37 music-server volumio[1175]: info: camilladsp spawned new process with pid 4030, instance 1, run: true Nov 21 14:49:38 music-server volumio[1175]: 0+0 records in Nov 21 14:49:38 music-server volumio[1175]: 0+0 records out Nov 21 14:49:38 music-server volumio[1175]: 0 bytes copied, 6.0971e-05 s, 0.0 kB/s Nov 21 14:49:38 music-server volumio[1175]: info: camilladsp spawned new process with pid 4035, instance 1, run: true Nov 21 14:49:39 music-server volumio[1175]: 0+0 records in Nov 21 14:49:39 music-server volumio[1175]: 0+0 records out Nov 21 14:49:39 music-server volumio[1175]: 0 bytes copied, 6.0658e-05 s, 0.0 kB/s Nov 21 14:49:39 music-server volumio[1175]: info: camilladsp spawned new process with pid 4054, instance 1, run: true Nov 21 14:49:40 music-server volumio[1175]: 0+0 records in Nov 21 14:49:40 music-server volumio[1175]: 0+0 records out Nov 21 14:49:40 music-server volumio[1175]: 0 bytes copied, 5.6033e-05 s, 0.0 kB/s Nov 21 14:49:40 music-server volumio[1175]: info: camilladsp spawned new process with pid 4059, instance 1, run: true Nov 21 14:49:41 music-server volumio[1175]: 0+0 records in Nov 21 14:49:41 music-server volumio[1175]: 0+0 records out Nov 21 14:49:41 music-server volumio[1175]: 0 bytes copied, 6.1309e-05 s, 0.0 kB/s Nov 21 14:49:41 music-server volumio[1175]: info: camilladsp spawned new process with pid 4064, instance 1, run: true Nov 21 14:49:41 music-server ntpd[1556]: Soliciting pool server 2a0c:b847:ffff:79::e53c Nov 21 14:49:42 music-server volumio[1175]: 0+0 records in Nov 21 14:49:42 music-server volumio[1175]: 0+0 records out Nov 21 14:49:42 music-server volumio[1175]: 0 bytes copied, 5.8318e-05 s, 0.0 kB/s Nov 21 14:49:42 music-server volumio[1175]: info: camilladsp spawned new process with pid 4069, instance 1, run: true Nov 21 14:49:43 music-server volumio[1175]: 0+0 records in Nov 21 14:49:43 music-server volumio[1175]: 0+0 records out Nov 21 14:49:43 music-server volumio[1175]: 0 bytes copied, 5.9421e-05 s, 0.0 kB/s Nov 21 14:49:43 music-server volumio[1175]: info: camilladsp spawned new process with pid 4077, instance 1, run: true Nov 21 14:49:44 music-server volumio[1175]: 0+0 records in Nov 21 14:49:44 music-server volumio[1175]: 0+0 records out Nov 21 14:49:44 music-server volumio[1175]: 0 bytes copied, 6.4039e-05 s, 0.0 kB/s Nov 21 14:49:44 music-server volumio[1175]: info: camilladsp spawned new process with pid 4082, instance 1, run: true Nov 21 14:49:44 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 14:49:44 music-server volumio[1175]: info: CURURI: music-library Nov 21 14:49:45 music-server volumio[1175]: info: Preload queue cleared Nov 21 14:49:45 music-server volumio[1175]: 0+0 records in Nov 21 14:49:45 music-server volumio[1175]: 0+0 records out Nov 21 14:49:45 music-server volumio[1175]: 0 bytes copied, 5.7639e-05 s, 0.0 kB/s Nov 21 14:49:45 music-server volumio[1175]: info: camilladsp spawned new process with pid 4087, instance 1, run: true Nov 21 14:49:46 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 14:49:46 music-server volumio[1175]: info: CURURI: music-library/USB Nov 21 14:49:46 music-server volumio[1175]: info: Preload queue cleared Nov 21 14:49:46 music-server volumio[1175]: 0+0 records in Nov 21 14:49:46 music-server volumio[1175]: 0+0 records out Nov 21 14:49:46 music-server volumio[1175]: 0 bytes copied, 5.42e-05 s, 0.0 kB/s Nov 21 14:49:46 music-server volumio[1175]: info: camilladsp spawned new process with pid 4092, instance 1, run: true Nov 21 14:49:47 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 14:49:47 music-server volumio[1175]: info: CURURI: music-library/USB/Seagate_Backup_Plus_Drive Nov 21 14:49:47 music-server volumio[1175]: info: Preload queue cleared Nov 21 14:49:47 music-server volumio[1175]: 0+0 records in Nov 21 14:49:47 music-server volumio[1175]: 0+0 records out Nov 21 14:49:47 music-server volumio[1175]: 0 bytes copied, 5.7485e-05 s, 0.0 kB/s Nov 21 14:49:47 music-server volumio[1175]: info: camilladsp spawned new process with pid 4097, instance 1, run: true Nov 21 14:49:48 music-server volumio[1175]: 0+0 records in Nov 21 14:49:48 music-server volumio[1175]: 0+0 records out Nov 21 14:49:48 music-server volumio[1175]: 0 bytes copied, 5.3398e-05 s, 0.0 kB/s Nov 21 14:49:48 music-server volumio[1175]: info: camilladsp spawned new process with pid 4120, instance 1, run: true Nov 21 14:49:49 music-server volumio[1175]: 0+0 records in Nov 21 14:49:49 music-server volumio[1175]: 0+0 records out Nov 21 14:49:49 music-server volumio[1175]: 0 bytes copied, 6.726e-05 s, 0.0 kB/s Nov 21 14:49:49 music-server volumio[1175]: info: camilladsp spawned new process with pid 4125, instance 1, run: true Nov 21 14:49:49 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 14:49:49 music-server volumio[1175]: info: CURURI: music-library/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI Nov 21 14:49:49 music-server volumio[1175]: info: Preload queue cleared Nov 21 14:49:50 music-server volumio[1175]: 0+0 records in Nov 21 14:49:50 music-server volumio[1175]: 0+0 records out Nov 21 14:49:50 music-server volumio[1175]: 0 bytes copied, 6.8855e-05 s, 0.0 kB/s Nov 21 14:49:50 music-server volumio[1175]: info: camilladsp spawned new process with pid 4130, instance 1, run: true Nov 21 14:49:51 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 21 14:49:51 music-server volumio[1175]: info: CURURI: music-library/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD Nov 21 14:49:51 music-server volumio[1175]: info: Preload queue cleared Nov 21 14:49:51 music-server volumio[1175]: 0+0 records in Nov 21 14:49:51 music-server volumio[1175]: 0+0 records out Nov 21 14:49:51 music-server volumio[1175]: 0 bytes copied, 6.332e-05 s, 0.0 kB/s Nov 21 14:49:51 music-server volumio[1175]: info: camilladsp spawned new process with pid 4135, instance 1, run: true Nov 21 14:49:52 music-server volumio[1175]: 0+0 records in Nov 21 14:49:52 music-server volumio[1175]: 0+0 records out Nov 21 14:49:52 music-server volumio[1175]: 0 bytes copied, 7.4006e-05 s, 0.0 kB/s Nov 21 14:49:52 music-server volumio[1175]: info: camilladsp spawned new process with pid 4143, instance 1, run: true Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::ClearQueue Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::stop Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::updateTrackBlock Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrackBlock Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::stPlaybackTimer Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::serviceStop Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::serviceStop Nov 21 14:49:53 music-server volumio[1175]: info: ControllerMpd::stop Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::clearPlayQueue Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::saveQueue Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::volumioPushQueue Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::addQueueItems Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::addQueueItems Nov 21 14:49:53 music-server volumio[1175]: info: Preload queue cleared Nov 21 14:49:53 music-server volumio[1175]: info: Adding Item to queue: music-library/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV Nov 21 14:49:53 music-server volumio[1175]: info: Exploding uri music-library/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV in service mpd Nov 21 14:49:53 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F01.%20Intro.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/01. Intro.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F02.%20Thu%20phoi%20pha.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/02. Thu phoi pha.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F03.%20Yeu%20anh%20mai%20mai.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/03. Yeu anh mai mai.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F04.%20Tinh%20thu%20menh%20mang.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/04. Tinh thu menh mang.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F05.%20Tinh%20nong%20tha%20thiet.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/05. Tinh nong tha thiet.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F06.%20Nhu%20trai%20tim%20ngay%20tho.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/06. Nhu trai tim ngay tho.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F07.%20Doa%20hong.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/07. Doa hong.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F08.%20Thu%20xa.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/08. Thu xa.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F09.%20Ngay%20hom%20qua.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/09. Ngay hom qua.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F10.%20Mot%20buoi%20chieu%20cuoi%20thu.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/10. Mot buoi chieu cuoi thu.wav Nov 21 14:49:53 music-server volumio[1175]: info: ALBUMART /albumart?cacheid=705&web=MTPStudio%20High%20Quality%20Audio%20-%200913366226/ASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Backup_Plus_Drive%2FCAC%20HANG%20BANG%20NHAC%20HAI%20NGOAI%2FASIA%20CD%2FASIA%20CD%20051%20-%20Tinh%20thu%20menh%20mang%20-%20Special%20%40WAV%2F11.%20Noi%20dau%20niem%20nho.wav&metadata=false Nov 21 14:49:53 music-server volumio[1175]: info: URI /mnt/USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/11. Noi dau niem nho.wav Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand stop took 83 milliseconds Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::volumioPushQueue Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::saveQueue Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::updateTrackBlock Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrackBlock Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::volumioPlay Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::play index 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::stop Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::play index undefined Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::startPlaybackTimer Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/01. Intro.wav Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand stop took 0 milliseconds Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 14:49:53 music-server volumio[1175]: info: Nov 21 14:49:53 music-server volumio[1175]: ---------------------------- MPD announces system playlist update Nov 21 14:49:53 music-server volumio[1175]: info: Ignoring MPD Status Update Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand clear took 2 milliseconds Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/01. Intro.wav" Nov 21 14:49:53 music-server volumio[1175]: error: updateQueue error: null Nov 21 14:49:53 music-server volumio[1175]: info: Nov 21 14:49:53 music-server volumio[1175]: ---------------------------- MPD announces system playlist update Nov 21 14:49:53 music-server volumio[1175]: info: Ignoring MPD Status Update Nov 21 14:49:53 music-server volumio[1175]: info: ------------------------------ 3ms Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand add "USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/01. Intro.wav" took 3 milliseconds Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand play Nov 21 14:49:53 music-server volumio[1175]: info: ------------------------------ 2ms Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand play took 3 milliseconds Nov 21 14:49:53 music-server volumio[1175]: info: Nov 21 14:49:53 music-server volumio[1175]: ---------------------------- MPD announces state update: player Nov 21 14:49:53 music-server volumio[1175]: info: ControllerMpd::getState Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:49:53 music-server volumio[1175]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 21 14:49:53 music-server volumio[1175]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 21 14:49:53 music-server volumio[1175]: info: camilladsp service terminated, instance 1 Nov 21 14:49:53 music-server volumio[1175]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 14:49:53 music-server volumio[1175]: info: camilladsp spawned new process with pid 4152, instance 1, run: true Nov 21 14:49:53 music-server volumio[1175]: info: camilladsp service started and running in background, instance 1 Nov 21 14:49:53 music-server volumio[1175]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 21 14:49:53 music-server volumio[1175]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 21 14:49:53 music-server volumio[1175]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 14:49:53 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:49:53 music-server volumio[1175]: 2+0 records in Nov 21 14:49:53 music-server volumio[1175]: 2+0 records out Nov 21 14:49:53 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000263756 s, 248 MB/s Nov 21 14:49:53 music-server volumio[1175]: info: Nov 21 14:49:53 music-server volumio[1175]: ---------------------------- MPD announces state update: player Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand status took 38 milliseconds Nov 21 14:49:53 music-server volumio[1175]: info: ControllerMpd::getState Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand status took 2 milliseconds Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::parseTrackInfo Nov 21 14:49:53 music-server volumio[1175]: info: ControllerMpd::pushState Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::servicePushState Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":78,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Intro.wav","artist":"MTPStudio High Quality Audio - 0913366226","album":"ASIA CD 051 - Tinh thu menh mang","uri":"USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/01. Intro.wav","trackType":"wav"} Nov 21 14:49:53 music-server volumio[1175]: verbose: CURRENT POSITION 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::syncState stateService play Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::syncState currentStatus stop Nov 21 14:49:53 music-server volumio[1175]: info: ------------------------------ 48ms Nov 21 14:49:53 music-server volumio[1175]: error: FusionDsp - WebSocket error: [object Object] Nov 21 14:49:53 music-server volumio[1175]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 21 14:49:53 music-server volumio[1175]: verbose: ControllerMpd::parseTrackInfo Nov 21 14:49:53 music-server volumio[1175]: info: ControllerMpd::pushState Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::servicePushState Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":78,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Intro.wav","artist":"MTPStudio High Quality Audio - 0913366226","album":"ASIA CD 051 - Tinh thu menh mang","uri":"USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/01. Intro.wav","trackType":"wav"} Nov 21 14:49:53 music-server volumio[1175]: verbose: CURRENT POSITION 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::syncState stateService play Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::syncState currentStatus play Nov 21 14:49:53 music-server volumio[1175]: info: Received an update from plugin. extracting info from payload Nov 21 14:49:53 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:53 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:49:53 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:54 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:49:54 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:54 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:49:54 music-server volumio[1175]: info: ------------------------------ 22ms Nov 21 14:49:54 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:54 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:49:55 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:49:55 music-server volumio[1175]: 165+1 records in Nov 21 14:49:55 music-server volumio[1175]: 165+1 records out Nov 21 14:49:55 music-server volumio[1175]: 5435632 bytes (5.4 MB, 5.2 MiB) copied, 0.0104634 s, 519 MB/s Nov 21 14:49:55 music-server volumio[1175]: info: camilladsp spawned new process with pid 4161, instance 1, run: true Nov 21 14:49:56 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:49:56 music-server volumio[1175]: 87+1 records in Nov 21 14:49:56 music-server volumio[1175]: 87+1 records out Nov 21 14:49:56 music-server volumio[1175]: 2879744 bytes (2.9 MB, 2.7 MiB) copied, 0.00577737 s, 498 MB/s Nov 21 14:49:56 music-server volumio[1175]: info: camilladsp spawned new process with pid 4166, instance 1, run: true Nov 21 14:49:57 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:49:57 music-server volumio[1175]: 2+0 records in Nov 21 14:49:57 music-server volumio[1175]: 2+0 records out Nov 21 14:49:57 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.00018755 s, 349 MB/s Nov 21 14:49:57 music-server volumio[1175]: info: camilladsp spawned new process with pid 4172, instance 1, run: true Nov 21 14:49:57 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 14:49:57 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 14:49:57 music-server volumio[1175]: info: Discovery: Getting this device information Nov 21 14:49:57 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:49:57 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:49:57 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 14:49:58 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:49:58 music-server volumio[1175]: 1+1 records in Nov 21 14:49:58 music-server volumio[1175]: 1+1 records out Nov 21 14:49:58 music-server volumio[1175]: 61712 bytes (62 kB, 60 KiB) copied, 0.000278063 s, 222 MB/s Nov 21 14:49:58 music-server volumio[1175]: info: camilladsp spawned new process with pid 4177, instance 1, run: true Nov 21 14:49:59 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:49:59 music-server volumio[1175]: 41+1 records in Nov 21 14:49:59 music-server volumio[1175]: 41+1 records out Nov 21 14:49:59 music-server volumio[1175]: 1370240 bytes (1.4 MB, 1.3 MiB) copied, 0.00273316 s, 501 MB/s Nov 21 14:49:59 music-server volumio[1175]: info: camilladsp spawned new process with pid 4196, instance 1, run: true Nov 21 14:50:00 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:00 music-server volumio[1175]: 61+1 records in Nov 21 14:50:00 music-server volumio[1175]: 61+1 records out Nov 21 14:50:00 music-server volumio[1175]: 2030512 bytes (2.0 MB, 1.9 MiB) copied, 0.00412532 s, 492 MB/s Nov 21 14:50:00 music-server volumio[1175]: info: camilladsp spawned new process with pid 4201, instance 1, run: true Nov 21 14:50:00 music-server volumiologrotate[677]: ls: cannot access '/var/log/samba/log.wb-MUSIC': No such file or directory Nov 21 14:50:00 music-server volumiologrotate[677]: ls: cannot access 'SERVER': No such file or directory Nov 21 14:50:01 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:01 music-server volumio[1175]: 2+0 records in Nov 21 14:50:01 music-server volumio[1175]: 2+0 records out Nov 21 14:50:01 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000267037 s, 245 MB/s Nov 21 14:50:01 music-server volumio[1175]: info: camilladsp spawned new process with pid 4253, instance 1, run: true Nov 21 14:50:02 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:02 music-server volumio[1175]: 1+1 records in Nov 21 14:50:02 music-server volumio[1175]: 1+1 records out Nov 21 14:50:02 music-server volumio[1175]: 61712 bytes (62 kB, 60 KiB) copied, 0.000264105 s, 234 MB/s Nov 21 14:50:02 music-server volumio[1175]: info: camilladsp spawned new process with pid 4258, instance 1, run: true Nov 21 14:50:03 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:03 music-server volumio[1175]: 80+1 records in Nov 21 14:50:03 music-server volumio[1175]: 80+1 records out Nov 21 14:50:03 music-server volumio[1175]: 2650096 bytes (2.7 MB, 2.5 MiB) copied, 0.00548919 s, 483 MB/s Nov 21 14:50:03 music-server volumio[1175]: info: camilladsp spawned new process with pid 4266, instance 1, run: true Nov 21 14:50:04 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:04 music-server volumio[1175]: 78+1 records in Nov 21 14:50:04 music-server volumio[1175]: 78+1 records out Nov 21 14:50:04 music-server volumio[1175]: 2588384 bytes (2.6 MB, 2.5 MiB) copied, 0.00489524 s, 529 MB/s Nov 21 14:50:04 music-server volumio[1175]: info: camilladsp spawned new process with pid 4271, instance 1, run: true Nov 21 14:50:05 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:05 music-server volumio[1175]: 1+1 records in Nov 21 14:50:05 music-server volumio[1175]: 1+1 records out Nov 21 14:50:05 music-server volumio[1175]: 61712 bytes (62 kB, 60 KiB) copied, 0.000266778 s, 231 MB/s Nov 21 14:50:05 music-server volumio[1175]: info: camilladsp spawned new process with pid 4276, instance 1, run: true Nov 21 14:50:06 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:06 music-server volumio[1175]: 2+0 records in Nov 21 14:50:06 music-server volumio[1175]: 2+0 records out Nov 21 14:50:06 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000280827 s, 233 MB/s Nov 21 14:50:06 music-server volumio[1175]: info: camilladsp spawned new process with pid 4281, instance 1, run: true Nov 21 14:50:07 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:07 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 21 14:50:07 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 21 14:50:07 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 21 14:50:07 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 21 14:50:07 music-server volumio[1175]: info: Received Get System Version Nov 21 14:50:07 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 21 14:50:07 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:07 music-server volumio[1175]: 27+1 records in Nov 21 14:50:07 music-server volumio[1175]: 27+1 records out Nov 21 14:50:07 music-server volumio[1175]: 914768 bytes (915 kB, 893 KiB) copied, 0.00186294 s, 491 MB/s Nov 21 14:50:07 music-server volumio[1175]: info: camilladsp spawned new process with pid 4293, instance 1, run: true Nov 21 14:50:08 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:08 music-server volumio[1175]: 28+1 records in Nov 21 14:50:08 music-server volumio[1175]: 28+1 records out Nov 21 14:50:08 music-server volumio[1175]: 943712 bytes (944 kB, 922 KiB) copied, 0.00188896 s, 500 MB/s Nov 21 14:50:08 music-server volumio[1175]: info: camilladsp spawned new process with pid 4312, instance 1, run: true Nov 21 14:50:09 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:09 music-server volumio[1175]: 30+1 records in Nov 21 14:50:09 music-server volumio[1175]: 30+1 records out Nov 21 14:50:09 music-server volumio[1175]: 1013072 bytes (1.0 MB, 989 KiB) copied, 0.00199881 s, 507 MB/s Nov 21 14:50:09 music-server volumio[1175]: info: camilladsp spawned new process with pid 4317, instance 1, run: true Nov 21 14:50:10 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:10 music-server volumio[1175]: 1+1 records in Nov 21 14:50:10 music-server volumio[1175]: 1+1 records out Nov 21 14:50:10 music-server volumio[1175]: 61712 bytes (62 kB, 60 KiB) copied, 0.000254507 s, 242 MB/s Nov 21 14:50:10 music-server volumio[1175]: info: camilladsp spawned new process with pid 4322, instance 1, run: true Nov 21 14:50:11 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:11 music-server volumio[1175]: 2+0 records in Nov 21 14:50:11 music-server volumio[1175]: 2+0 records out Nov 21 14:50:11 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000210565 s, 311 MB/s Nov 21 14:50:11 music-server volumio[1175]: info: camilladsp spawned new process with pid 4327, instance 1, run: true Nov 21 14:50:12 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:12 music-server volumio[1175]: 1+1 records in Nov 21 14:50:12 music-server volumio[1175]: 1+1 records out Nov 21 14:50:12 music-server volumio[1175]: 61712 bytes (62 kB, 60 KiB) copied, 0.000241329 s, 256 MB/s Nov 21 14:50:12 music-server volumio[1175]: info: camilladsp spawned new process with pid 4332, instance 1, run: true Nov 21 14:50:13 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:13 music-server volumio[1175]: 2+0 records in Nov 21 14:50:13 music-server volumio[1175]: 2+0 records out Nov 21 14:50:13 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000262542 s, 250 MB/s Nov 21 14:50:13 music-server volumio[1175]: info: camilladsp spawned new process with pid 4340, instance 1, run: true Nov 21 14:50:14 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:14 music-server volumio[1175]: 215+1 records in Nov 21 14:50:14 music-server volumio[1175]: 215+1 records out Nov 21 14:50:14 music-server volumio[1175]: 7076160 bytes (7.1 MB, 6.7 MiB) copied, 0.0131416 s, 538 MB/s Nov 21 14:50:14 music-server volumio[1175]: info: camilladsp spawned new process with pid 4345, instance 1, run: true Nov 21 14:50:14 music-server volumio[1175]: info: Nov 21 14:50:14 music-server volumio[1175]: ---------------------------- MPD announces state update: player Nov 21 14:50:14 music-server volumio[1175]: info: ControllerMpd::getState Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand status took 0 milliseconds Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:50:14 music-server volumio[1175]: info: ControllerMpd::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::servicePushState Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 0 Nov 21 14:50:14 music-server volumio[1175]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 21 14:50:14 music-server volumio[1175]: verbose: CURRENT POSITION 0 Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::syncState stateService stop Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::syncState currentStatus play Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::play index undefined Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::startPlaybackTimer Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/04. Tinh thu menh mang.wav Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 14:50:14 music-server volumio[1175]: info: ------------------------------ 17ms Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand stop took 10 milliseconds Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 14:50:14 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:50:14 music-server volumio[1175]: info: Nov 21 14:50:14 music-server volumio[1175]: ---------------------------- MPD announces system playlist update Nov 21 14:50:14 music-server volumio[1175]: info: Ignoring MPD Status Update Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand clear took 9 milliseconds Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/04. Tinh thu menh mang.wav" Nov 21 14:50:14 music-server volumio[1175]: error: updateQueue error: null Nov 21 14:50:14 music-server volumio[1175]: info: Nov 21 14:50:14 music-server volumio[1175]: ---------------------------- MPD announces system playlist update Nov 21 14:50:14 music-server volumio[1175]: info: Ignoring MPD Status Update Nov 21 14:50:14 music-server volumio[1175]: info: ------------------------------ 3ms Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand add "USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/04. Tinh thu menh mang.wav" took 1 milliseconds Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand play Nov 21 14:50:14 music-server volumio[1175]: info: ------------------------------ 5ms Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand play took 5 milliseconds Nov 21 14:50:14 music-server volumio[1175]: info: Nov 21 14:50:14 music-server volumio[1175]: ---------------------------- MPD announces state update: player Nov 21 14:50:14 music-server volumio[1175]: info: ControllerMpd::getState Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:50:14 music-server volumio[1175]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 21 14:50:14 music-server volumio[1175]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 21 14:50:14 music-server volumio[1175]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 14:50:14 music-server volumio[1175]: error: FusionDsp - WebSocket error: [object Object] Nov 21 14:50:14 music-server volumio[1175]: info: Nov 21 14:50:14 music-server volumio[1175]: ---------------------------- MPD announces state update: player Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand status took 10 milliseconds Nov 21 14:50:14 music-server volumio[1175]: info: ControllerMpd::getState Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand status Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand status took 2 milliseconds Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::parseState Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::parseTrackInfo Nov 21 14:50:14 music-server volumio[1175]: info: ControllerMpd::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::servicePushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"04. Tinh thu menh mang.wav","artist":"MTPStudio High Quality Audio - 0913366226","album":"ASIA CD 051 - Tinh thu menh mang","uri":"USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/04. Tinh thu menh mang.wav","trackType":"wav"} Nov 21 14:50:14 music-server volumio[1175]: verbose: CURRENT POSITION 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::syncState stateService play Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::syncState currentStatus stop Nov 21 14:50:14 music-server volumio[1175]: info: ------------------------------ 14ms Nov 21 14:50:14 music-server volumio[1175]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 21 14:50:14 music-server volumio[1175]: verbose: ControllerMpd::parseTrackInfo Nov 21 14:50:14 music-server volumio[1175]: info: ControllerMpd::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::servicePushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"04. Tinh thu menh mang.wav","artist":"MTPStudio High Quality Audio - 0913366226","album":"ASIA CD 051 - Tinh thu menh mang","uri":"USB/Seagate_Backup_Plus_Drive/CAC HANG BANG NHAC HAI NGOAI/ASIA CD/ASIA CD 051 - Tinh thu menh mang - Special @WAV/04. Tinh thu menh mang.wav","trackType":"wav"} Nov 21 14:50:14 music-server volumio[1175]: verbose: CURRENT POSITION 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::syncState stateService play Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::syncState currentStatus play Nov 21 14:50:14 music-server volumio[1175]: info: Received an update from plugin. extracting info from payload Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:50:14 music-server volumio[1175]: info: CoreStateMachine::pushState Nov 21 14:50:14 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:14 music-server volumio[1175]: info: CoreCommandRouter::volumioPushState Nov 21 14:50:14 music-server volumio[1175]: info: ------------------------------ 23ms Nov 21 14:50:14 music-server volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Nov 21 14:50:15 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:15 music-server volumio[1175]: 2+0 records in Nov 21 14:50:15 music-server volumio[1175]: 2+0 records out Nov 21 14:50:15 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000288687 s, 227 MB/s Nov 21 14:50:15 music-server volumio[1175]: info: camilladsp spawned new process with pid 4351, instance 1, run: true Nov 21 14:50:16 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:16 music-server volumio[1175]: 176+1 records in Nov 21 14:50:16 music-server volumio[1175]: 176+1 records out Nov 21 14:50:16 music-server volumio[1175]: 5792528 bytes (5.8 MB, 5.5 MiB) copied, 0.0116599 s, 497 MB/s Nov 21 14:50:16 music-server volumio[1175]: info: camilladsp spawned new process with pid 4357, instance 1, run: true Nov 21 14:50:17 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Nov 21 14:50:17 music-server volumio[1175]: info: CoreCommandRouter::Reload Ui Nov 21 14:50:17 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:17 music-server volumio[1175]: 30+1 records in Nov 21 14:50:17 music-server volumio[1175]: 30+1 records out Nov 21 14:50:17 music-server volumio[1175]: 1013072 bytes (1.0 MB, 989 KiB) copied, 0.00211164 s, 480 MB/s Nov 21 14:50:17 music-server volumio[1175]: info: camilladsp spawned new process with pid 4362, instance 1, run: true Nov 21 14:50:18 music-server sudo[4381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 14:50:18 music-server sudo[4381]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:18 music-server sudo[4381]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:18 music-server sudo[4384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 14:50:18 music-server sudo[4384]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:18 music-server sudo[4384]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:18 music-server volumio[1175]: verbose: New Socket.io Connection to 192.168.1.3 from 192.168.1.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::volumioGetVisibleSources Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 21 14:50:18 music-server volumio[1175]: info: Received Get System Info Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 14:50:18 music-server volumio[1175]: info: Discovery: Getting this device information Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:50:18 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 14:50:18 music-server volumio-remote-updater[680]: No test mode Nov 21 14:50:18 music-server volumio-remote-updater[680]: No alpha test mode Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:18 music-server volumio[1175]: info: Retrieving Cloud Streaming UI Nov 21 14:50:18 music-server volumio[1175]: info: Getting Tidal Cloud Configuration Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:18 music-server volumio[1175]: info: Getting Qobuz Cloud Configuration Nov 21 14:50:18 music-server volumio[1175]: info: Asking plugin for UI Config Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:18 music-server volumio[1175]: info: Getting Spotify Cloud Configuration Nov 21 14:50:18 music-server volumio[1175]: info: Asking plugin for UI Config Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:18 music-server volumio[1175]: info: Saving Spotify Acccount Nov 21 14:50:18 music-server volumio[1175]: info: Got Tidal Cloud Configuration Nov 21 14:50:18 music-server volumio[1175]: info: Got it Nov 21 14:50:18 music-server volumio[1175]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 21 14:50:18 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:18 music-server volumio[1175]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 21 14:50:18 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:18 music-server volumio[1175]: 26+1 records in Nov 21 14:50:18 music-server volumio[1175]: 26+1 records out Nov 21 14:50:18 music-server volumio[1175]: 882000 bytes (882 kB, 861 KiB) copied, 0.00202657 s, 435 MB/s Nov 21 14:50:18 music-server volumio[1175]: info: camilladsp spawned new process with pid 4392, instance 1, run: true Nov 21 14:50:18 music-server volumio[1175]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 21 14:50:19 music-server volumio[1175]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::volumioGetVisibleSources Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Nov 21 14:50:19 music-server volumio[1175]: info: Received Get System Info Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 21 14:50:19 music-server volumio[1175]: info: Discovery: Getting this device information Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::volumioGetState Nov 21 14:50:19 music-server volumio[1175]: info: CorePlayQueue::getTrack 3 Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 21 14:50:19 music-server volumio-remote-updater[680]: No test mode Nov 21 14:50:19 music-server volumio-remote-updater[680]: No alpha test mode Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:19 music-server volumio[1175]: info: Retrieving Cloud Streaming UI Nov 21 14:50:19 music-server volumio[1175]: info: Getting Tidal Cloud Configuration Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:19 music-server volumio[1175]: info: Getting Qobuz Cloud Configuration Nov 21 14:50:19 music-server volumio[1175]: info: Asking plugin for UI Config Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:19 music-server volumio[1175]: info: Getting Spotify Cloud Configuration Nov 21 14:50:19 music-server volumio[1175]: info: Asking plugin for UI Config Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:19 music-server volumio[1175]: info: Saving Spotify Acccount Nov 21 14:50:19 music-server volumio[1175]: info: Got Tidal Cloud Configuration Nov 21 14:50:19 music-server volumio[1175]: info: Got it Nov 21 14:50:19 music-server volumio[1175]: info: Got it Nov 21 14:50:19 music-server volumio[1175]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 21 14:50:19 music-server volumio[1175]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 21 14:50:19 music-server volumio[1175]: info: Loading i18n strings for locale vi Nov 21 14:50:19 music-server volumio[1175]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Nov 21 14:50:19 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 21 14:50:19 music-server volumio[1175]: info: Setting timezone to Asia/Saigon Nov 21 14:50:19 music-server sudo[4400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 21 14:50:19 music-server sudo[4400]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:19 music-server sudo[4400]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:19 music-server sudo[4403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Saigon /etc/localtime Nov 21 14:50:19 music-server sudo[4403]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:19 music-server sudo[4403]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:19 music-server sudo[4406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 21 14:50:19 music-server sudo[4406]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:19 music-server sudo[4406]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:19 music-server sudo[4409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon Nov 21 14:50:19 music-server sudo[4409]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:19 music-server dbus-daemon[681]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.27' (uid=0 pid=4410 comm="/usr/bin/timedatectl set-timezone Asia/Saigon ") Nov 21 14:50:19 music-server systemd[1]: Starting Time & Date Service... Nov 21 14:50:20 music-server dbus-daemon[681]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 21 14:50:20 music-server systemd[1]: Started Time & Date Service. Nov 21 14:50:20 music-server sudo[4409]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:20 music-server volumio[1175]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 21 14:50:20 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:20 music-server volumio[1175]: 24+1 records in Nov 21 14:50:20 music-server volumio[1175]: 24+1 records out Nov 21 14:50:20 music-server volumio[1175]: 816464 bytes (816 kB, 797 KiB) copied, 0.00201007 s, 406 MB/s Nov 21 14:50:20 music-server volumio[1175]: info: camilladsp spawned new process with pid 4414, instance 1, run: true Nov 21 14:50:20 music-server volumio[1175]: Updating browse sources language Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source Mixcloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source SoundCloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube2 Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube Music Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source Mixcloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source SoundCloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube2 Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube Music Nov 21 14:50:20 music-server volumio[1175]: info: Fetching Streaming Services browse cache Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 21 14:50:20 music-server volumio[1175]: info: Loading i18n strings for locale en Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 21 14:50:20 music-server volumio[1175]: info: Setting timezone to UTC Nov 21 14:50:20 music-server sudo[4418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 21 14:50:20 music-server sudo[4418]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:20 music-server sudo[4418]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:20 music-server sudo[4421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime Nov 21 14:50:20 music-server sudo[4421]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:20 music-server sudo[4421]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:20 music-server sudo[4424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 21 14:50:20 music-server sudo[4424]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:20 music-server sudo[4424]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:20 music-server sudo[4427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Nov 21 14:50:20 music-server sudo[4427]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:20 music-server systemd-timedated[4411]: Failed to set time zone: Permission denied Nov 21 14:50:20 music-server sudo[4427]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:20 music-server volumio[1175]: Failed to set time zone: Access denied Nov 21 14:50:20 music-server volumio[1175]: info: Could not set timezone, retrying Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 21 14:50:20 music-server volumio[1175]: Updating browse sources language Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source Mixcloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source SoundCloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube2 Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube Music Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source Mixcloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source SoundCloud Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube2 Nov 21 14:50:20 music-server volumio[1175]: Cannot find translation for source YouTube Music Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 21 14:50:20 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 21 14:50:21 music-server volumio[1175]: info: Fetching Streaming Services browse cache Nov 21 14:50:21 music-server volumio[1175]: /bin/dd: error reading '/tmp/fusiondspfifo': Resource temporarily unavailable Nov 21 14:50:21 music-server volumio[1175]: 2+0 records in Nov 21 14:50:21 music-server volumio[1175]: 2+0 records out Nov 21 14:50:21 music-server volumio[1175]: 65536 bytes (66 kB, 64 KiB) copied, 0.000266097 s, 246 MB/s Nov 21 14:50:21 music-server volumio[1175]: info: camilladsp spawned new process with pid 4431, instance 1, run: true Nov 21 14:50:21 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Nov 21 14:50:21 music-server volumio[1175]: info: Loading i18n strings for locale vi Nov 21 14:50:21 music-server volumio[1175]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Nov 21 14:50:21 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Nov 21 14:50:21 music-server volumio[1175]: info: Setting timezone to Asia/Saigon Nov 21 14:50:21 music-server sudo[4435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Nov 21 14:50:21 music-server sudo[4435]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:21 music-server sudo[4435]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:21 music-server sudo[4438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Saigon /etc/localtime Nov 21 14:50:21 music-server sudo[4438]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:21 music-server sudo[4438]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:21 music-server sudo[4441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Nov 21 14:50:21 music-server sudo[4441]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:21 music-server sudo[4441]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:21 music-server sudo[4444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Saigon Nov 21 14:50:21 music-server sudo[4444]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:21 music-server systemd-timedated[4411]: Failed to set time zone: Permission denied Nov 21 14:50:21 music-server sudo[4444]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:21 music-server volumio[1175]: Failed to set time zone: Access denied Nov 21 14:50:21 music-server volumio[1175]: info: Could not set timezone, retrying Nov 21 14:50:21 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 21 14:50:21 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 21 14:50:21 music-server sudo[4447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 21 14:50:21 music-server sudo[4447]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:21 music-server volumio[1175]: Updating browse sources language Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source Mixcloud Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source SoundCloud Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source YouTube2 Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source YouTube Music Nov 21 14:50:21 music-server volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source Mixcloud Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source SoundCloud Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source YouTube2 Nov 21 14:50:21 music-server volumio[1175]: Cannot find translation for source YouTube Music Nov 21 14:50:21 music-server volumio[1175]: info: Fetching Streaming Services browse cache Nov 21 14:50:21 music-server sudo[4450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Nov 21 14:50:21 music-server sudo[4450]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 14:50:21 music-server systemd-timedated[4411]: Failed to set time zone: Permission denied Nov 21 14:50:21 music-server sudo[4450]: pam_unix(sudo:session): session closed for user root Nov 21 14:50:21 music-server volumio[1175]: Failed to set time zone: Access denied Nov 21 14:50:21 music-server volumio[1175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 14:50:21 music-server volumio[1175]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'UTC' Nov 21 14:50:21 music-server volumio[1175]: Failed to set time zone: Access denied Nov 21 14:50:21 music-server volumio[1175]: at checkExecSyncError (child_process.js:790:11) Nov 21 14:50:21 music-server volumio[1175]: at execSync (child_process.js:863:15) Nov 21 14:50:21 music-server volumio[1175]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Nov 21 14:50:21 music-server volumio[1175]: at listOnTimeout (internal/timers.js:557:17) Nov 21 14:50:21 music-server volumio[1175]: at processTimers (internal/timers.js:500:7) { Nov 21 14:50:21 music-server volumio[1175]: status: 1, Nov 21 14:50:21 music-server volumio[1175]: signal: null, Nov 21 14:50:21 music-server volumio[1175]: output: [ null, '', 'Failed to set time zone: Access denied\n' ], Nov 21 14:50:21 music-server volumio[1175]: pid: 4449, Nov 21 14:50:21 music-server volumio[1175]: stdout: '', Nov 21 14:50:21 music-server volumio[1175]: stderr: 'Failed to set time zone: Access denied\n' Nov 21 14:50:21 music-server volumio[1175]: } Nov 21 14:50:21 music-server volumio[1175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 14:50:21 music-server sudo[4461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 14:49 Nov 21 14:50:21 music-server sudo[4461]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"