-- Logs begin at Sun 2024-08-25 09:45:21 UTC, end at Sun 2024-08-25 09:58:58 UTC. -- Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: Restoring Previous Volume level: 66 false false Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: Volume configurations have been set Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2 Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: Disabling external Volume Control Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: VolumeController:: Volume=66 Mute =false Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:57:12 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:57:12 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Aug 25 09:57:16 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume66 Aug 25 09:57:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:57:16 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:57:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:57:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:57:16 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Aug 25 09:57:25 vaishaks-speakers volumiologrotate[773]: ls: cannot access "/var/log/samba/log.wb-VAISHAK'S": No such file or directory Aug 25 09:57:25 vaishaks-speakers volumiologrotate[773]: ls: cannot access 'SPEAKERS': No such file or directory Aug 25 09:57:30 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:57:37 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 09:57:37 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="emitting websocket event: not_playing" Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","play_origin":"search"}} Aug 25 09:57:44 vaishaks-speakers volumio[1220]: error: Failed to decode event: not_playing Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="loading track (paused: true, position: 0ms)" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="cleared closed output device" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="emitting websocket event: will_play" Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","play_origin":"search"}} Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="selected format OGG_VORBIS_160 (5127efc04e60749daf95fecbbc360bfe3257f995)" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="requested aes key for file 5127efc04e60749daf95fecbbc360bfe3257f995, gid: 4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="fetched first chunk of 8, total size is 3879672 bytes" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="seek to 0ms (diff: -152ms, samples: 0, bytes: 0)" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 16666 us, period size = 735 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 30 frames" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="created new output device" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=info msg="loaded track \"Here Comes Your Man\" (paused: true, position: 0ms, duration: 201186ms, prefetched: false)" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="emitting websocket event: metadata" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="emitting websocket event: stopped" Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=trace msg="emitting websocket event: stopped" Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","name":"Here Comes Your Man","artist_names":["Pixies"],"album_name":"Doolittle","album_cover_url":"https://i.scdn.co/image/ab67616d00001e020ab3c2a306c614fae36ff1d6","position":0,"duration":201186,"release_date":"year:1989 month:4 day:17","track_number":5,"disc_number":1}} Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"search"}} Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: PUSH STATE SPOTIFY Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: {"status":"stop","service":"spop","title":"Here Comes Your Man","artist":"Pixies","album":"Doolittle","albumart":"https://i.scdn.co/image/ab67616d00001e020ab3c2a306c614fae36ff1d6","uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","trackType":"spotify","seek":0,"duration":201,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::servicePushState Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:57:44 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:44Z" level=debug msg="fetched chunk 1/7, size: 524288" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CorePlayQueue::getTrack 0 Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received spop Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"search"}} Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: PUSH STATE SPOTIFY Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: {"status":"stop","service":"spop","title":"Here Comes Your Man","artist":"Pixies","album":"Doolittle","albumart":"https://i.scdn.co/image/ab67616d00001e020ab3c2a306c614fae36ff1d6","uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","trackType":"spotify","seek":0,"duration":201,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::servicePushState Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: CorePlayQueue::getTrack 0 Aug 25 09:57:44 vaishaks-speakers volumio[1220]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received spop Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Aug 25 09:57:44 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Aug 25 09:57:45 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:45Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 09:57:45 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:45Z" level=trace msg="emitting websocket event: paused" Aug 25 09:57:45 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","play_origin":"search"}} Aug 25 09:57:45 vaishaks-speakers volumio[1220]: SPOTIFY: PUSH STATE SPOTIFY Aug 25 09:57:45 vaishaks-speakers volumio[1220]: SPOTIFY: {"status":"pause","service":"spop","title":"Here Comes Your Man","artist":"Pixies","album":"Doolittle","albumart":"https://i.scdn.co/image/ab67616d00001e020ab3c2a306c614fae36ff1d6","uri":"spotify:track:4IvZLDtwBHmBmwgDIUbuwa","trackType":"spotify","seek":0,"duration":201,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 25 09:57:45 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::servicePushState Aug 25 09:57:45 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:57:45 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:57:45 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:57:45 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Aug 25 09:57:45 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:45Z" level=debug msg="fetched chunk 3/7, size: 524288" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:45 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:57:45Z" level=debug msg="fetched chunk 2/7, size: 524288" uri="spotify:track:4IvZLDtwBHmBmwgDIUbuwa" Aug 25 09:57:45 vaishaks-speakers volumio[1220]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Aug 25 09:57:45 vaishaks-speakers ntpd[1209]: 162.159.200.123 local addr 192.168.29.217 -> Aug 25 09:57:50 vaishaks-speakers volumio[1220]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Aug 25 09:57:50 vaishaks-speakers volumio[1220]: info: Folder /tmp/plugins removed Aug 25 09:57:51 vaishaks-speakers volumio[1220]: info: Check plugin dependencies Aug 25 09:57:51 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 09:57:51 vaishaks-speakers volumio[1220]: info: Checking if plugin already exists Aug 25 09:57:51 vaishaks-speakers volumio[1220]: info: Rename folder Aug 25 09:57:51 vaishaks-speakers volumio[1220]: info: Folder /tmp/downloaded_plugin.zip removed Aug 25 09:57:51 vaishaks-speakers volumio[1220]: info: Move to category Aug 25 09:58:11 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:11Z" level=debug msg="handling play player command from 6b273186c168d98b1b2fa06e01cdc35f436977b2" Aug 25 09:58:11 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:11Z" level=debug msg="resolved context of track" uri="spotify:search" Aug 25 09:58:11 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:11Z" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:search" Aug 25 09:58:11 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:11Z" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=trace msg="emitting websocket event: will_play" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="selected format OGG_VORBIS_160 (7102f4d060b71c2349703e37d1f9d837dfc0c131)" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="requested aes key for file 7102f4d060b71c2349703e37d1f9d837dfc0c131, gid: 7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="fetched first chunk of 9, total size is 4299180 bytes" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=trace msg="seek to 0ms (diff: -198ms, samples: 0, bytes: 0)" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 16666 us, period size = 735 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 30 frames" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=info msg="loaded track \"Chamber Of Reflection\" (paused: false, position: 0ms, duration: 231723ms, prefetched: false)" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="vorbis: corrupt or missing data in bitstream" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=trace msg="scheduling prefetch in 201s" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=trace msg="emitting websocket event: metadata" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="sending successful reply for dealer request" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="fetched chunk 3/8, size: 524288" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="fetched chunk 2/8, size: 524288" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="fetched chunk 1/8, size: 524288" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 09:58:12 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:12Z" level=trace msg="emitting websocket event: playing" Aug 25 09:58:13 vaishaks-speakers volumio-remote-updater[769]: [2024-08-25 09:58:13] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Aug 25 09:58:15 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:15Z" level=debug msg="update volume to 43908/65535" Aug 25 09:58:15 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:15Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:15 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:15Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: Checking if install.sh is present Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: Executing install.sh Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7H7NyZ3G075GqPx2evsfeb","play_origin":"search"}} Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7H7NyZ3G075GqPx2evsfeb","name":"Chamber Of Reflection","artist_names":["Mac DeMarco"],"album_name":"Salad Days","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02ec6e9c13eeed14eedbd5f7c9","position":0,"duration":231723,"release_date":"year:2014 month:4 day:1","track_number":9,"disc_number":1}} Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7H7NyZ3G075GqPx2evsfeb","play_origin":"search"}} Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: PUSH STATE SPOTIFY Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: {"status":"play","service":"spop","title":"Chamber Of Reflection","artist":"Mac DeMarco","album":"Salad Days","albumart":"https://i.scdn.co/image/ab67616d00001e02ec6e9c13eeed14eedbd5f7c9","uri":"spotify:track:7H7NyZ3G075GqPx2evsfeb","trackType":"spotify","seek":0,"duration":231,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::servicePushState Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":67,"max":100}} Aug 25 09:58:15 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 67 Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 67 Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume67 Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:15 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:15 vaishaks-speakers volumio[1220]: 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: 1 Aug 25 09:58:15 vaishaks-speakers volumio[1220]: 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: 2 Aug 25 09:58:15 vaishaks-speakers volumio[1220]: 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: 3 Aug 25 09:58:16 vaishaks-speakers sudo[2784]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:16 vaishaks-speakers sudo[2784]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:16 vaishaks-speakers sudo[2784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Aug 25 09:58:16 vaishaks-speakers sudo[2784]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: creating filters folder and copying demo filters Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: copying demo flters Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=debug msg="update volume to 44563/65535" Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: Installing/fusiondsp dependencies Aug 25 09:58:16 vaishaks-speakers sudo[2806]: root : unable to resolve host vaishaks-speakers Aug 25 09:58:16 vaishaks-speakers sudo[2806]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:16 vaishaks-speakers sudo[2806]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Aug 25 09:58:16 vaishaks-speakers sudo[2806]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:16 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":68,"max":100}} Aug 25 09:58:16 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 68 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 68 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume68 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: SPOTIFY: PUSH STATE SPOTIFY Aug 25 09:58:16 vaishaks-speakers volumio[1220]: SPOTIFY: {"status":"play","service":"spop","title":"Chamber Of Reflection","artist":"Mac DeMarco","album":"Salad Days","albumart":"https://i.scdn.co/image/ab67616d00001e02ec6e9c13eeed14eedbd5f7c9","uri":"spotify:track:7H7NyZ3G075GqPx2evsfeb","trackType":"spotify","seek":0,"duration":231,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::servicePushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: Get:1 http://deb.debian.org/debian buster InRelease [122 kB] Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: Hit:2 https://deb.nodesource.com/node_14.x buster InRelease Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=debug msg="update volume to 45219/65535" Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:16 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":69,"max":100}} Aug 25 09:58:16 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 69 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 69 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume69 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:16 vaishaks-speakers volumio[1220]: info: Get:3 http://deb.debian.org/debian buster/main i386 Packages [7866 kB] Aug 25 09:58:16 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:16Z" level=debug msg="update volume to 45874/65535" Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":70,"max":100}} Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 70 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 70 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume70 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=debug msg="update volume to 46529/65535" Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":71,"max":100}} Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 71 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 71 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume71 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=debug msg="update volume to 47185/65535" Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:17 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:17Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":72,"max":100}} Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 72 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 72 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume72 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: 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: 7 Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetVisibleSources Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: Received Get System Info Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: Discovery: Getting this device information Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: Listing playlists Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetQueue Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CoreStateMachine::getQueue Aug 25 09:58:17 vaishaks-speakers volumio[1220]: info: CorePlayQueue::getQueue Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: Get:4 http://deb.debian.org/debian buster/main amd64 Packages [7909 kB] Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: Get:5 http://deb.debian.org/debian buster/main Translation-en [5969 kB] Aug 25 09:58:18 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:18Z" level=debug msg="update volume to 47840/65535" Aug 25 09:58:18 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:18Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:18 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:18Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:18 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":73,"max":100}} Aug 25 09:58:18 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 73 Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 73 Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume73 Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:18 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:18 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Aug 25 09:58:18 vaishaks-speakers volumio-remote-updater[769]: [2024-08-25 09:58:18] [connect] Successful connection Aug 25 09:58:18 vaishaks-speakers volumio[1220]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8 Aug 25 09:58:18 vaishaks-speakers volumio-remote-updater[769]: [2024-08-25 09:58:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724579898 101 Aug 25 09:58:22 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:22Z" level=debug msg="update volume to 47185/65535" Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":72,"max":100}} Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 72 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 72 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume72 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72 Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=debug msg="update volume to 46529/65535" Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":71,"max":100}} Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 71 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 71 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume71 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=debug msg="update volume to 45219/65535" Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:23 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:23Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":69,"max":100}} Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 69 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 69 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume69 Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:23 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:23 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=debug msg="update volume to 44563/65535" Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":68,"max":100}} Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 68 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 68 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume68 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=debug msg="update volume to 45874/65535" Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":70,"max":100}} Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 70 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 70 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume70 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=debug msg="update volume to 45218/65535" Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:24 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:24Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":69,"max":100}} Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 69 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 69 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume69 Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:24 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:24 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 69 Aug 25 09:58:25 vaishaks-speakers volumiologrotate[773]: ls: cannot access "/var/log/samba/log.wb-VAISHAK'S": No such file or directory Aug 25 09:58:25 vaishaks-speakers volumiologrotate[773]: ls: cannot access 'SPEAKERS': No such file or directory Aug 25 09:58:25 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:25Z" level=debug msg="update volume to 45219/65535" Aug 25 09:58:25 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:25Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:25 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:25Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:25 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":69,"max":100}} Aug 25 09:58:25 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 69 Aug 25 09:58:25 vaishaks-speakers volumio[1220]: info: Get:6 http://deb.debian.org/debian buster/contrib i386 Packages [46.0 kB] Aug 25 09:58:25 vaishaks-speakers volumio[1220]: info: Get:7 http://deb.debian.org/debian buster/contrib amd64 Packages [50.1 kB] Aug 25 09:58:25 vaishaks-speakers volumio[1220]: info: Get:8 http://deb.debian.org/debian buster/contrib Translation-en [44.2 kB] Aug 25 09:58:25 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:25Z" level=debug msg="update volume to 44564/65535" Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":69,"max":100}} Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 69 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: Get:9 http://deb.debian.org/debian buster/non-free i386 Packages [76.3 kB] Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: Get:10 http://deb.debian.org/debian buster/non-free amd64 Packages [87.8 kB] Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: Get:11 http://deb.debian.org/debian buster/non-free Translation-en [88.9 kB] Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=debug msg="update volume to 43908/65535" Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":67,"max":100}} Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 67 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 67 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume67 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=debug msg="update volume to 43253/65535" Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:26 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:26Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":66,"max":100}} Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 66 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 66 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume66 Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:26 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:26 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Aug 25 09:58:27 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:27Z" level=debug msg="update volume to 42598/65535" Aug 25 09:58:27 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:27Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:27 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:27Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:27 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":66,"max":100}} Aug 25 09:58:27 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 66 Aug 25 09:58:27 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:27Z" level=debug msg="update volume to 41942/65535" Aug 25 09:58:27 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:27Z" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 09:58:27 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:27Z" level=trace msg="emitting websocket event: volume" Aug 25 09:58:27 vaishaks-speakers volumio[1220]: SPOTIFY: received: {"type":"volume","data":{"value":64,"max":100}} Aug 25 09:58:27 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED SPOTIFY VOLUME 64 Aug 25 09:58:27 vaishaks-speakers volumio[1220]: info: Setting Volumio Volume from Spotify: 64 Aug 25 09:58:27 vaishaks-speakers volumio[1220]: info: VolumeController::SetAlsaVolume64 Aug 25 09:58:27 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:27 vaishaks-speakers volumio[1220]: info: CoreStateMachine::pushState Aug 25 09:58:27 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 09:58:27 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioPushState Aug 25 09:58:28 vaishaks-speakers volumio[1220]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Aug 25 09:58:39 vaishaks-speakers go-librespot[1657]: time="2024-08-25T09:58:39Z" level=debug msg="fetched chunk 4/8, size: 524288" uri="spotify:track:7H7NyZ3G075GqPx2evsfeb" Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: Enabling plugin fusiondsp Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: Loading plugin "fusiondsp"... Aug 25 09:58:55 vaishaks-speakers volumio[1220]: error: Could not copy default configuration to /data/configuration/audio_interface/fusiondsp/config.json Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: Preparing to generate the ALSA configuration file Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: Asound.conf file unchanged, so no further update is needed Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: Output device has changed, restarting MPD Aug 25 09:58:55 vaishaks-speakers sudo[3081]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:55 vaishaks-speakers sudo[3081]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:55 vaishaks-speakers sudo[3081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 25 09:58:55 vaishaks-speakers sudo[3081]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:55 vaishaks-speakers sudo[3081]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: Output device has changed, restarting Shairport Sync Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:55 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 09:58:55 vaishaks-speakers sudo[3084]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:55 vaishaks-speakers sudo[3084]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:55 vaishaks-speakers sudo[3084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 25 09:58:55 vaishaks-speakers sudo[3084]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:55 vaishaks-speakers systemd[1]: Stopping Music Player Daemon... Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: PLUGIN START: fusiondsp Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: Loading i18n strings for locale en Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: FusionDsp - mixtype--------------------- Hardware Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: Preparing to generate the ALSA configuration file Aug 25 09:58:56 vaishaks-speakers volumio[1220]: info: Done. Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: MPD Permissions set Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::volumioGetState Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Asound.conf file unchanged, so no further update is needed Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Output device has changed, restarting MPD Aug 25 09:58:57 vaishaks-speakers sudo[3096]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:57 vaishaks-speakers sudo[3096]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:57 vaishaks-speakers sudo[3096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 25 09:58:57 vaishaks-speakers sudo[3096]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:57 vaishaks-speakers sudo[3096]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Output device has changed, restarting Shairport Sync Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 09:58:57 vaishaks-speakers sudo[3099]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:57 vaishaks-speakers sudo[3099]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:57 vaishaks-speakers sudo[3099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 25 09:58:57 vaishaks-speakers sudo[3099]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 09:58:57 vaishaks-speakers systemd[1]: mpd.service: Succeeded. Aug 25 09:58:57 vaishaks-speakers systemd[1]: Stopped Music Player Daemon. Aug 25 09:58:57 vaishaks-speakers systemd[1]: Starting Music Player Daemon... Aug 25 09:58:57 vaishaks-speakers sudo[3104]: root : unable to resolve host vaishaks-speakers Aug 25 09:58:57 vaishaks-speakers sudo[3104]: sudo: unable to resolve host vaishaks-speakers: System error Aug 25 09:58:57 vaishaks-speakers sudo[3104]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:57 vaishaks-speakers sudo[3104]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 25 09:58:57 vaishaks-speakers sudo[3104]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:57 vaishaks-speakers sudo[3104]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: MPD Permissions set Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Starting Shairport Sync Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 25 09:58:57 vaishaks-speakers sudo[3109]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:57 vaishaks-speakers sudo[3109]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:57 vaishaks-speakers sudo[3109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 09:58:57 vaishaks-speakers sudo[3109]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Starting Shairport Sync Aug 25 09:58:57 vaishaks-speakers systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 25 09:58:57 vaishaks-speakers systemd[1]: shairport-sync.service: Succeeded. Aug 25 09:58:57 vaishaks-speakers systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 25 09:58:57 vaishaks-speakers volumio[1220]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/audio_interface/fusiondsp/config.json' Aug 25 09:58:57 vaishaks-speakers systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 25 09:58:57 vaishaks-speakers sudo[3118]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:57 vaishaks-speakers sudo[3118]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:57 vaishaks-speakers sudo[3109]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Shairport-Sync Started Aug 25 09:58:57 vaishaks-speakers sudo[3118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 09:58:57 vaishaks-speakers sudo[3118]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 09:58:57 vaishaks-speakers systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 25 09:58:57 vaishaks-speakers systemd[1]: shairport-sync.service: Succeeded. Aug 25 09:58:57 vaishaks-speakers systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 25 09:58:57 vaishaks-speakers systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 25 09:58:57 vaishaks-speakers sudo[3118]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:57 vaishaks-speakers volumio[1220]: info: Shairport-Sync Started Aug 25 09:58:58 vaishaks-speakers mpd[3107]: Aug 25 09:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 25 09:58:58 vaishaks-speakers sudo[3084]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:58 vaishaks-speakers systemd[1]: Started Music Player Daemon. Aug 25 09:58:58 vaishaks-speakers sudo[3099]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:58 vaishaks-speakers volumio[1220]: error: MPD error: The expression evaluated to a falsy value: Aug 25 09:58:58 vaishaks-speakers volumio[1220]: assert.ok(self.idling) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: error: The expression evaluated to a falsy value: Aug 25 09:58:58 vaishaks-speakers volumio[1220]: assert.ok(self.idling) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: error: updateQueue error: null Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: camilladsp service started and running in background, instance 1 Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 09:58:58 vaishaks-speakers volumio[1220]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent Aug 25 09:58:58 vaishaks-speakers volumio[1220]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 25 09:58:58 vaishaks-speakers volumio[1220]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: FusionDsp loaded Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: Adding Signal Path Element [object Object] Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: Adding fusiondspeq DSP Signal Path Element Aug 25 09:58:58 vaishaks-speakers volumio[1220]: info: FusionDsp - ---- installed callbackRead Aug 25 09:58:58 vaishaks-speakers volumio[1220]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 09:58:58 vaishaks-speakers volumio[1220]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 25 09:58:58 vaishaks-speakers volumio[1220]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: at onErrorNT (internal/child_process.js:472:16) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: at runNextTicks (internal/process/task_queues.js:64:3) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: at listOnTimeout (internal/timers.js:526:9) Aug 25 09:58:58 vaishaks-speakers volumio[1220]: at processTimers (internal/timers.js:500:7) { Aug 25 09:58:58 vaishaks-speakers volumio[1220]: errno: -2, Aug 25 09:58:58 vaishaks-speakers volumio[1220]: code: 'ENOENT', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: spawnargs: [ Aug 25 09:58:58 vaishaks-speakers volumio[1220]: '-p', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: 9876, Aug 25 09:58:58 vaishaks-speakers volumio[1220]: '-o', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: '/tmp/camilladsp.log', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: '-l', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: 'warn', Aug 25 09:58:58 vaishaks-speakers volumio[1220]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 25 09:58:58 vaishaks-speakers volumio[1220]: ] Aug 25 09:58:58 vaishaks-speakers volumio[1220]: } Aug 25 09:58:58 vaishaks-speakers volumio[1220]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 09:58:58 vaishaks-speakers sudo[3140]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:58 vaishaks-speakers sudo[3140]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:58 vaishaks-speakers sudo[3140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 25 09:58:58 vaishaks-speakers sudo[3140]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 09:58:58 vaishaks-speakers sudo[3140]: pam_unix(sudo:session): session closed for user root Aug 25 09:58:58 vaishaks-speakers sudo[3151]: volumio : unable to resolve host vaishaks-speakers Aug 25 09:58:58 vaishaks-speakers sudo[3151]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 25 09:58:58 vaishaks-speakers sudo[3151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-25 09:57 Aug 25 09:58:58 vaishaks-speakers sudo[3151]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"