-- Logs begin at Wed 2025-11-05 02:13:40 +03, end at Wed 2025-11-05 02:18:13 +03. -- Nov 05 02:17:07 volumio go-librespot[1640]: time="2025-11-05T02:17:07+03:00" level=trace msg="sent dealer ping" Nov 05 02:17:07 volumio go-librespot[1640]: time="2025-11-05T02:17:07+03:00" level=trace msg="received dealer pong" Nov 05 02:17:23 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Nov 05 02:17:25 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 05 02:17:25 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 05 02:17:25 volumio volumio[1147]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 02:17:25 volumio volumio[1147]: info: FusionDsp - Bass-FusionDsp Nov 05 02:17:25 volumio volumio[1147]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces state update: player Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::getState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand status took 1 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseState Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 05 02:17:27 volumio volumio[1147]: verbose: CURRENT POSITION 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState stateService stop Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState currentStatus play Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::play index undefined Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::startPlaybackTimer Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: info: [1762298247526] ControllerWebradio::clearAddPlayTrack Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 14ms Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand stop took 9 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand clear Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] CurState: play PrevState: play Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] CurState: stop PrevState: play Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] CurState: stop PrevState: play Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces system playlist update Nov 05 02:17:27 volumio volumio[1147]: info: Ignoring MPD Status Update Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand clear took 15 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand load "http://hayatmix.net/stream?type=http&nocache=13295" Nov 05 02:17:27 volumio volumio[1147]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 05 02:17:27 volumio volumio[1147]: error: updateQueue error: null Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 135ms Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand add "http://hayatmix.net/stream?type=http&nocache=13295" Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces system playlist update Nov 05 02:17:27 volumio volumio[1147]: info: Ignoring MPD Status Update Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand add "http://hayatmix.net/stream?type=http&nocache=13295" took 0 milliseconds Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand play Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 1ms Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand play took 0 milliseconds Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces state update: player Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::getState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces state update: player Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand status took 11 milliseconds Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::getState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand status took 1 milliseconds Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?type=http&nocache=13295","artist":null,"album":null,"uri":"http://hayatmix.net/stream?type=http&nocache=13295","trackType":""} Nov 05 02:17:27 volumio volumio[1147]: verbose: CURRENT POSITION 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState stateService play Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState currentStatus stop Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 13ms Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?type=http&nocache=13295","artist":null,"album":null,"uri":"http://hayatmix.net/stream?type=http&nocache=13295","trackType":""} Nov 05 02:17:27 volumio volumio[1147]: verbose: CURRENT POSITION 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState stateService play Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState currentStatus play Nov 05 02:17:27 volumio volumio[1147]: info: Received an update from plugin. extracting info from payload Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 14ms Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] CurState: play PrevState: play Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] CurState: play PrevState: play Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:27 volumio volumio[1147]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces system playlist update Nov 05 02:17:27 volumio volumio[1147]: info: Ignoring MPD Status Update Nov 05 02:17:27 volumio volumio[1147]: info: Nov 05 02:17:27 volumio volumio[1147]: ---------------------------- MPD announces state update: player Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::getState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 1ms Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand status took 0 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseState Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 02:17:27 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 05 02:17:27 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Nov 05 02:17:27 volumio volumio[1147]: info: ControllerMpd::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"stream?type=http&nocache=13295","artist":null,"album":null,"uri":"http://hayatmix.net/stream?type=http&nocache=13295","trackType":""} Nov 05 02:17:27 volumio volumio[1147]: verbose: CURRENT POSITION 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState stateService play Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::syncState currentStatus play Nov 05 02:17:27 volumio volumio[1147]: info: Received an update from plugin. extracting info from payload Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:17:27 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:17:27 volumio volumio[1147]: info: ------------------------------ 12ms Nov 05 02:17:27 volumio volumio[1147]: info: [ASDebug] CurState: play PrevState: play Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:27 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:17:29 volumio go-librespot[1640]: time="2025-11-05T02:17:29+03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Nov 05 02:17:29 volumio volumio[1147]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Nov 05 02:17:29 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 02:17:29 volumio sudo[3141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Nov 05 02:17:29 volumio sudo[3141]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:29 volumio volumio[1147]: info: Disabling plugin spop Nov 05 02:17:29 volumio volumio[1147]: info: Done. Nov 05 02:17:29 volumio volumio[1147]: info: Connection to go-librespot Websocket closed Nov 05 02:17:29 volumio systemd[1]: Stopping go-librespot Daemon... Nov 05 02:17:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Nov 05 02:17:29 volumio volumio[1147]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 02:17:29 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Nov 05 02:17:29 volumio systemd[1]: Stopped go-librespot Daemon. Nov 05 02:17:29 volumio volumio[1147]: info: FusionDsp - Bass-FusionDsp Nov 05 02:17:29 volumio sudo[3141]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:29 volumio volumio[1147]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Nov 05 02:17:32 volumio volumio[1147]: info: FusionDsp - Stopping FusionDsp service Nov 05 02:17:32 volumio volumio[1147]: info: camilladsp stopping service pid 3125... Nov 05 02:17:32 volumio volumio[1147]: info: camilladsp service terminated, instance 1 Nov 05 02:17:32 volumio volumio[1147]: info: Disabling plugin fusiondsp Nov 05 02:17:32 volumio volumio[1147]: info: Preparing to generate the ALSA configuration file Nov 05 02:17:32 volumio sudo[3166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Nov 05 02:17:32 volumio sudo[3166]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:32 volumio volumio[1147]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 05 02:17:32 volumio volumio[1147]: info: Reading ALSA contributions from plugins. Nov 05 02:17:32 volumio volumio[1147]: info: Asound.conf file written Nov 05 02:17:32 volumio systemd[1]: Stopping FusionDsp Daemon... Nov 05 02:17:32 volumio volumio[1521]: Backend configuration: Nov 05 02:17:32 volumio volumio[1521]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Nov 05 02:17:32 volumio volumio[1521]: active_config_txt: null Nov 05 02:17:32 volumio volumio[1521]: camilla_host: 127.0.0.1 Nov 05 02:17:32 volumio volumio[1521]: camilla_port: 9876 Nov 05 02:17:32 volumio volumio[1521]: coeff_dir: /data/INTERNAL/FusionDsp/filters Nov 05 02:17:32 volumio volumio[1521]: config_dir: /data/configuration/audio_interface/fusiondsp Nov 05 02:17:32 volumio volumio[1521]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Nov 05 02:17:32 volumio volumio[1521]: log_file: /tmp/camilladsp.log Nov 05 02:17:32 volumio volumio[1521]: on_get_active_config: null Nov 05 02:17:32 volumio volumio[1521]: on_set_active_config: null Nov 05 02:17:32 volumio volumio[1521]: port: 5011 Nov 05 02:17:32 volumio volumio[1521]: supported_capture_types: null Nov 05 02:17:32 volumio volumio[1521]: supported_playback_types: null Nov 05 02:17:32 volumio volumio[1521]: update_config_symlink: false Nov 05 02:17:32 volumio volumio[1521]: update_config_txt: false Nov 05 02:17:32 volumio volumio[1521]: ======== Running on http://0.0.0.0:5011 ======== Nov 05 02:17:32 volumio volumio[1521]: (Press CTRL+C to quit) Nov 05 02:17:32 volumio sudo[3169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 05 02:17:32 volumio sudo[3169]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:32 volumio sudo[3169]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:32 volumio volumio[1147]: info: Output device has changed, restarting MPD Nov 05 02:17:32 volumio sudo[3174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 05 02:17:32 volumio sudo[3174]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:32 volumio sudo[3174]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:32 volumio volumio[1147]: info: Output device has changed, restarting Shairport Sync Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 02:17:32 volumio sudo[3177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 05 02:17:32 volumio sudo[3177]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:32 volumio systemd[1]: Stopping Music Player Daemon... Nov 05 02:17:32 volumio volumio[1147]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 05 02:17:32 volumio systemd[1]: mpd.service: Succeeded. Nov 05 02:17:32 volumio volumio[1147]: info: Done. Nov 05 02:17:32 volumio systemd[1]: Stopped Music Player Daemon. Nov 05 02:17:32 volumio volumio[1147]: info: MPD Permissions set Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:32 volumio volumio[1147]: info: Starting Shairport Sync Nov 05 02:17:32 volumio sudo[3188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 05 02:17:32 volumio sudo[3188]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:32 volumio systemd[1]: Starting Music Player Daemon... Nov 05 02:17:32 volumio systemd[1]: fusiondsp.service: Succeeded. Nov 05 02:17:32 volumio systemd[1]: Stopped FusionDsp Daemon. Nov 05 02:17:32 volumio sudo[3166]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:32 volumio volumio[1147]: info: FusionDsp - Reporting Fusion DSP Disabled Nov 05 02:17:32 volumio volumio[1147]: info: Removing fusiondspeq DSP Signal Path Element Nov 05 02:17:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 05 02:17:32 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 05 02:17:32 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 05 02:17:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 05 02:17:32 volumio sudo[3188]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:32 volumio volumio[1147]: info: Shairport-Sync Started Nov 05 02:17:32 volumio sudo[3182]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 05 02:17:32 volumio sudo[3182]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:32 volumio sudo[3182]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:32 volumio mpd[3192]: Nov 05 02:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 05 02:17:32 volumio systemd[1]: Started Music Player Daemon. Nov 05 02:17:32 volumio sudo[3177]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:32 volumio volumio[1147]: error: updateQueue error: null Nov 05 02:17:32 volumio volumio[1147]: error: Upnp client error: Error: This socket has been ended by the other party Nov 05 02:17:34 volumio volumio[1147]: info: [ASDebug] Port: 2 Nov 05 02:17:34 volumio volumio[1147]: info: [ASDebug] Inverted: false Nov 05 02:17:34 volumio volumio[1147]: info: [ASDebug] Delay: 720 Nov 05 02:17:34 volumio sudo[3201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Nov 05 02:17:34 volumio sudo[3201]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:34 volumio sudo[3201]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:34 volumio sudo[3204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Nov 05 02:17:34 volumio sudo[3204]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:34 volumio sudo[3207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Nov 05 02:17:34 volumio sudo[3207]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:34 volumio volumio[1147]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Nov 05 02:17:34 volumio sudo[3211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Nov 05 02:17:34 volumio sudo[3211]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:34 volumio systemd[1]: Started Getty on tty1. Nov 05 02:17:34 volumio sudo[3204]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:34 volumio volumio[1147]: info: touch_display: systemctl start getty@tty1.service succeeded. Nov 05 02:17:34 volumio systemd[1]: Reloading. Nov 05 02:17:35 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 05 02:17:35 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 05 02:17:35 volumio sudo[3207]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:35 volumio systemd[1]: Stopping Volumio Kiosk... Nov 05 02:17:35 volumio volumio[1147]: info: touch_display: systemctl enable getty@tty1.service succeeded. Nov 05 02:17:35 volumio startx[2253]: xinit: connection to X server lost Nov 05 02:17:35 volumio startx[2253]: [1B blob data] Nov 05 02:17:35 volumio startx[2253]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Nov 05 02:17:36 volumio startx[2253]: xinit: unexpected signal 15 Nov 05 02:17:36 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Nov 05 02:17:36 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Nov 05 02:17:36 volumio systemd[1]: Stopped Volumio Kiosk. Nov 05 02:17:36 volumio sudo[3211]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:36 volumio volumio[1147]: info: touch_display: systemctl stop volumio-kiosk.service succeeded. Nov 05 02:17:36 volumio volumio[1147]: info: Disabling plugin touch_display Nov 05 02:17:36 volumio volumio[1147]: info: Done. Nov 05 02:17:40 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Nov 05 02:17:48 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Nov 05 02:17:49 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 05 02:17:49 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 05 02:17:51 volumio volumio[1147]: info: Enabling plugin spop Nov 05 02:17:51 volumio volumio[1147]: info: Loading plugin "spop"... Nov 05 02:17:51 volumio volumio[1147]: info: PLUGIN START: spop Nov 05 02:17:51 volumio volumio[1147]: info: Creating Spotify config file Nov 05 02:17:51 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 05 02:17:51 volumio volumio[1147]: info: Done. Nov 05 02:17:51 volumio volumio[1147]: info: No need to fix Spotify hosts Nov 05 02:17:51 volumio volumio[1147]: info: Spotify config file written Nov 05 02:17:51 volumio sudo[3342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 05 02:17:51 volumio sudo[3342]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 05 02:17:52 volumio systemd[1]: Started go-librespot Daemon. Nov 05 02:17:52 volumio go-librespot[3344]: go-librespot daemon starting... Nov 05 02:17:52 volumio sudo[3342]: pam_unix(sudo:session): session closed for user root Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=info msg="running go-librespot 0.4.0" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="app state loaded" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 05 02:17:52 volumio volumio[1147]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 05 02:17:52 volumio volumio[1147]: SPOTIFY: BQB_mX9BdZYFD2GU_Q4gtAkNoKmxvEv3R381HnWOYZvdlt0bTuxv3uruKd6znyrbeZzRNWV2t7yPn6rOmUCnZrkFanVBlk0iLMWHdeA2Z-_S4MddFN8MCL9lZN1GqH7MNLPsHXiCG0sw1S_3WijrdhNWy84uhHs6zibgMStu7-qvQHHMMlm08p26oY0VNQoyinpq_GbM7VihEbJQyXOL1wuTNlnhcgkTKaX_uY5Mv8dGJRMTwnVXIsS3oW36t5BTKmNR4wDxNJbA0xdfd9SgMEXnGAVYLQmhn_UApw Nov 05 02:17:52 volumio volumio[1147]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 05 02:17:52 volumio volumio[1147]: info: New Spotify access token = BQB_mX9BdZYFD2GU_Q4gtAkNoKmxvEv3R381HnWOYZvdlt0bTuxv3uruKd6znyrbeZzRNWV2t7yPn6rOmUCnZrkFanVBlk0iLMWHdeA2Z-_S4MddFN8MCL9lZN1GqH7MNLPsHXiCG0sw1S_3WijrdhNWy84uhHs6zibgMStu7-qvQHHMMlm08p26oY0VNQoyinpq_GbM7VihEbJQyXOL1wuTNlnhcgkTKaX_uY5Mv8dGJRMTwnVXIsS3oW36t5BTKmNR4wDxNJbA0xdfd9SgMEXnGAVYLQmhn_UApw Nov 05 02:17:52 volumio volumio[1147]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=info msg="zeroconf server listening on port 40189" Nov 05 02:17:52 volumio volumio[1147]: SPOTIFY: User informations: {"country":"TR","display_name":"Sezgin Sözen","email":"sezginsozen@hotmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/sezginsozen"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/sezginsozen","id":"sezginsozen","images":[{"height":300,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=10162399162515256&height=300&width=300&ext=1764889513&hash=AT9va_FPT2TjfiClvEqZePPH","width":300},{"height":64,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=10162399162515256&height=50&width=50&ext=1764889513&hash=AT_SbsTLe9hVPCLie53HBRVm","width":64}],"product":"premium","type":"user","uri":"spotify:user:sezginsozen"} Nov 05 02:17:52 volumio volumio[1147]: info: Spotify Successfully logged in Nov 05 02:17:52 volumio volumio[1147]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 05 02:17:52 volumio volumio[1147]: info: [1762298272444] CoreMusicLibrary::Adding element Spotify Nov 05 02:17:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 05 02:17:52 volumio volumio[1147]: Cannot find translation for source Spotify Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="obtained new client token: AACWHMOlrXFm+IqDwBr/E16Ke649OPnskMdk4WKOtARS1MmI1iLzxfSOzOVu+NkcRFKJguXDy6WPKcH1rovQmZVqgX6W60BRGfSwkuv9pO9g8LVIJNyV+lkayCtthZw7koq3fYedwqmId6jecdznsKNdy9l/cnuzCVm/SHPqKHSelMZ6Zag8IbyyHWPuEkuipZKQrqcFbeq5mct7lMAGVFM1l3h4FOCMoV+8LdfnRwt4XqpSKlZp3ek7wUM=" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="completed keyexchange" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="completed challenge" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=info msg="authenticated AP" username="se*******en" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=info msg="authenticated Login5" username="se*******en" Nov 05 02:17:52 volumio go-librespot[3344]: time="2025-11-05T02:17:52+03:00" level=debug msg="initializing zeroconf session" username="se*******en" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="dealer connection opened" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=trace msg="starting accesspoint recv loop" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=trace msg="starting dealer recv loop" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=trace msg="received accesspoint ping" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="received connection id: YjY4YTQwZGEtZmE4...OUU3NDI0QjdEQQ==" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=trace msg="received accesspoint pong ack" Nov 05 02:17:53 volumio go-librespot[3344]: time="2025-11-05T02:17:53+03:00" level=debug msg="put connect state because NEW_DEVICE" Nov 05 02:17:53 volumio volumio[1147]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 05 02:17:55 volumio volumio[1147]: info: go-librespot daemon successfully initialized Nov 05 02:17:58 volumio volumio[1147]: info: Initializing connection to go-librespot Websocket Nov 05 02:17:58 volumio go-librespot[3344]: time="2025-11-05T02:17:58+03:00" level=debug msg="new websocket client" Nov 05 02:17:58 volumio volumio[1147]: info: Connection to go-librespot Websocket established Nov 05 02:17:58 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 05 02:17:58 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 05 02:18:01 volumio volumio[1147]: info: Getting Spotify volume Nov 05 02:18:01 volumio volumio[1147]: info: Spotify volume: 100 Nov 05 02:18:01 volumio volumio[1147]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 05 02:18:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Nov 05 02:18:01 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:18:01 volumio volumio[1147]: SPOTIFY: SPOTIFY VOLUME 100 Nov 05 02:18:01 volumio volumio[1147]: SPOTIFY: VOLUMIO VOLUME 64 Nov 05 02:18:01 volumio volumio[1147]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 05 02:18:01 volumio volumio[1147]: info: Setting Spotify Volume from Volumio: 64 Nov 05 02:18:02 volumio volumio[1147]: SPOTIFY: SETTING SPOTIFY VOLUME 64 Nov 05 02:18:02 volumio volumio[1147]: info: Sending Spotify command with payload to local API: /player/volume Nov 05 02:18:02 volumio go-librespot[3344]: time="2025-11-05T02:18:02+03:00" level=debug msg="update volume requested to 41942/65535" Nov 05 02:18:02 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Nov 05 02:18:02 volumio go-librespot[3344]: time="2025-11-05T02:18:02+03:00" level=debug msg="put connect state because VOLUME_CHANGED" Nov 05 02:18:02 volumio go-librespot[3344]: time="2025-11-05T02:18:02+03:00" level=trace msg="emitting websocket event: volume" Nov 05 02:18:02 volumio volumio[1147]: SPOTIFY: received: {"type":"volume","data":{"value":64,"max":100}} Nov 05 02:18:02 volumio volumio[1147]: SPOTIFY: RECEIVED SPOTIFY VOLUME 64 Nov 05 02:18:04 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Nov 05 02:18:04 volumio volumio[1147]: info: In handleBrowseUri, curUri=spotify Nov 05 02:18:04 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:04 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:04 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:04 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:08 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Nov 05 02:18:08 volumio volumio[1147]: info: In handleBrowseUri, curUri=spotify:playlist:37i9dQZF1DX5H8QSpChffy Nov 05 02:18:08 volumio go-librespot[3344]: time="2025-11-05T02:18:08+03:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 137" Nov 05 02:18:08 volumio go-librespot[3344]: time="2025-11-05T02:18:08+03:00" level=debug msg="skipping dealer message" uri="hm://playlist/v2/playlist/37i9dQZF1DX5H8QSpChffy" Nov 05 02:18:10 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6yBVZ7n0GwTdITxphKiuG8 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:7zSjskxzmhkzg9TD25JmFJ Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:5R62yrYVMRZExYqxoPnQMn Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2vsqjcIGoGK4opKEhVWqf0 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6JyMiVVXptfohf6S2zaAXv Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3GXkYMKJ443tsH5KmOABnw Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4dJHOcTO4jWVTrNYiNtJmf Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6UX8nGE5sT7FsUAgQILD6X Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6g6MHm9u0h2Em9Xuk89eqR Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:20bfCJHvuoPdziZacHdvNe Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4WfaeGpZO2YvXMbUfbpK7i Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2PCLG4X21rCtq5xK9I2xP7 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:01Oqk2alks3YD8mN5bA95w Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:7DCwqBp1HcEHXbwgVrmQxm Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4HoQXTijn6dVcOxQD3GHRs Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4xAEqYu3zsb8gcs91ngXUx Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1eZfubCc0Qf0VgDioyks9j Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4T73JmNNhtkFBzjRfCeMzN Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3sgBQybW08n0CzVmkOEtAp Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2fFoXj2aUlaezPp3SinfSD Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2luWadHsYhuZJF54vw4bTb Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6IXDRacqWKBzee5DgsLRVf Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6kbIemHzAcnM60eHdrUI4u Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4UJ3pCmsJORyCa8uO3dklS Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6OodgbaFCaBejPQo4RjOtm Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6mlg2VcNguCkGOKQ8AwoQA Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4OER4Y89FuWMqpALKUMySl Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:5T4DlSBcqRhKdUljhPFb5D Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:26uHtSrQXUad9uCqxPiIXJ Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:7zjN55DPbr8CxhfrwqP1qj Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1QuL5ALIuQ6djrKNT7BXy2 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:7ghVCUCGqdIyRfcTZyyxU8 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4OjNQv8on0pFfArve1BvTQ Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4zTOUtukd52LzS3bLWwzGc Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:7I1HcvlIhaPgN368uSndoc Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1NRJ9kVLsK3UicyVA2k8bI Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:30DEgnb76AxLZgrrvqNErB Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3rTnSsUS6gD2BDnMlPB2u8 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:05JumBI7m66oyRFX0OU1mp Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1d02igesB9DREknAVXRiBd Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:0oVnsgyHclNnGeEb4hRoYO Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:0gyoObUS4WilJyNRs6GlDv Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2G8uYPKcg3HAMnyxAEAwpH Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:30P0bhT0Ebfl9Bxua0mzYr Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6LATAa81iyMHWhXgI4VHwL Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:51yVTZAAXjMuOCiBvN980F Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2PtfdRfzzZasYANp1o9HD9 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3lJOIGsFylH947nMpYzfGO Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2MvC6PUwqLJbM3qluKK5EF Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4UqZRNx9idkEeO9Nj94ath Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1xEpgyKx4ZHtefFAh0SmU5 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6Trva7pHXIFHRa5QaGLGdK Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:50CggGOY2D2IKTuSRcn9nU Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3hZO58Vun13s6i8WCDhRDo Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3UgBLWFgadLahNGxTDYG2d Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:5bmRxKsHXgoQvl4MYlUJTr Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:5E1gxNXvUGvpvUECz54xXm Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4AtAwuCD03LKGSzob85XOW Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:34NtMvhl3m4w4MnrBQPXsN Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:2xIC5DmTHaGBL83a9OUXM4 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1iEMuRRbD04w92WzHYkJrF Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:5ikFGOKtCdl9YC2xJh9hho Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1XSHAC96a1iNeOsq4bqe4o Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6Z3WU4RClDxXoNUX4YRfJV Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:6wE2kwWJpEWuKGxlN1DMKi Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:77v2LD9V5QenHV6xYSkFXh Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4mxxUBAI07uBTa4cvFgTsB Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1IIInPteMS5PPK9E1EdWA2 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1tTdrG3Bb5uKRO4zbSctUf Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:70p0jJB0M3d2RVUjr6AVug Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:3IcAfhBe6frmou4B6zC8M5 Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:4k38Yez6CcsKyD8mJd44nq Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:5Q6cDjM0JuvGu2mxulXGwo Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:05BUSUeDYEI5lcZJchaivT Nov 05 02:18:10 volumio volumio[1147]: info: Preloading song: spotify:track:1c4ikmUvVFjVQbMsliYkmu Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:6yBVZ7n0GwTdITxphKiuG8 in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6yBVZ7n0GwTdITxphKiuG8 Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:7zSjskxzmhkzg9TD25JmFJ in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:7zSjskxzmhkzg9TD25JmFJ Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:5R62yrYVMRZExYqxoPnQMn in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:5R62yrYVMRZExYqxoPnQMn Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:2vsqjcIGoGK4opKEhVWqf0 in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:2vsqjcIGoGK4opKEhVWqf0 Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:6JyMiVVXptfohf6S2zaAXv in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6JyMiVVXptfohf6S2zaAXv Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:3GXkYMKJ443tsH5KmOABnw in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:3GXkYMKJ443tsH5KmOABnw Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7zSjskxzmhkzg9TD25JmFJ","service":"spop","name":"Ay İnanmıyorum","artist":"Aşkın Nur Yengi","album":"Kara Çiçeğim","type":"song","duration":261,"albumart":"https://i.scdn.co/image/ab67616d0000b273ac6a84c15328dda047d4d301","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6yBVZ7n0GwTdITxphKiuG8","service":"spop","name":"Şuh Nefes - Ceceli","artist":"Sezen Aksu","album":"Paşa Gönül Şarkıları","type":"song","duration":201,"albumart":"https://i.scdn.co/image/ab67616d0000b27344a47d5ca77f73be1afe6d96","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:4dJHOcTO4jWVTrNYiNtJmf in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4dJHOcTO4jWVTrNYiNtJmf Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:6UX8nGE5sT7FsUAgQILD6X in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6UX8nGE5sT7FsUAgQILD6X Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5R62yrYVMRZExYqxoPnQMn","service":"spop","name":"Be Adam","artist":"Gülşen","album":"Be Adam","type":"song","duration":207,"albumart":"https://i.scdn.co/image/ab67616d0000b273ff4671045e918d21b2b48ea5","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2vsqjcIGoGK4opKEhVWqf0","service":"spop","name":"Gidelim Mi Buralardan","artist":"İrem Derici","album":"Gidelim Mi Buralardan","type":"song","duration":160,"albumart":"https://i.scdn.co/image/ab67616d0000b2731e3b484cca3d7f50796d681a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:6g6MHm9u0h2Em9Xuk89eqR in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6g6MHm9u0h2Em9Xuk89eqR Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6JyMiVVXptfohf6S2zaAXv","service":"spop","name":"Cennet","artist":"Ebru Gündeş","album":"Âşık","type":"song","duration":213,"albumart":"https://i.scdn.co/image/ab67616d0000b27394f863c41c8c2f8c00e6432f","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:20bfCJHvuoPdziZacHdvNe in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:20bfCJHvuoPdziZacHdvNe Nov 05 02:18:10 volumio volumio[1147]: info: Exploding uri spotify:track:4WfaeGpZO2YvXMbUfbpK7i in service spop Nov 05 02:18:10 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4WfaeGpZO2YvXMbUfbpK7i Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:2PCLG4X21rCtq5xK9I2xP7 in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:2PCLG4X21rCtq5xK9I2xP7 Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3GXkYMKJ443tsH5KmOABnw","service":"spop","name":"Cesaretsizce Olmuyor","artist":"Jabbar","album":"Yineleme","type":"song","duration":192,"albumart":"https://i.scdn.co/image/ab67616d0000b27386b39af8a8e5cc315c5397b2","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4dJHOcTO4jWVTrNYiNtJmf","service":"spop","name":"Eyvah","artist":"Zeynep Bastık","album":"Eyvah","type":"song","duration":147,"albumart":"https://i.scdn.co/image/ab67616d0000b2733a26201b6317608acaf301c5","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:01Oqk2alks3YD8mN5bA95w in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:01Oqk2alks3YD8mN5bA95w Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6UX8nGE5sT7FsUAgQILD6X","service":"spop","name":"Lafı mı Olur","artist":"Kibariye","album":"İşte Ses İşte Yorum","type":"song","duration":212,"albumart":"https://i.scdn.co/image/ab67616d0000b27328fbeef8017a5a3eebb9cde0","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:7DCwqBp1HcEHXbwgVrmQxm in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:7DCwqBp1HcEHXbwgVrmQxm Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6g6MHm9u0h2Em9Xuk89eqR","service":"spop","name":"Arıyorum","artist":"EDIS","album":"Arıyorum","type":"song","duration":193,"albumart":"https://i.scdn.co/image/ab67616d0000b2733b3aacdcd3277dec936a3a9a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:4HoQXTijn6dVcOxQD3GHRs in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4HoQXTijn6dVcOxQD3GHRs Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:20bfCJHvuoPdziZacHdvNe","service":"spop","name":"Aşktan Ne Haber","artist":"Sezen Aksu","album":"Yaz Bitmeden","type":"song","duration":237,"albumart":"https://i.scdn.co/image/ab67616d0000b273ef525adf786248b31faddc5c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4WfaeGpZO2YvXMbUfbpK7i","service":"spop","name":"Mod","artist":"Mustafa Sandal","album":"Mod","type":"song","duration":183,"albumart":"https://i.scdn.co/image/ab67616d0000b27310bbabb2fe4f4b7037e013bf","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:4xAEqYu3zsb8gcs91ngXUx in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4xAEqYu3zsb8gcs91ngXUx Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:1eZfubCc0Qf0VgDioyks9j in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:1eZfubCc0Qf0VgDioyks9j Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:01Oqk2alks3YD8mN5bA95w","service":"spop","name":"Sana Bayılıyorum","artist":"Zeynep Bastık","album":"Zeynodisco","type":"song","duration":156,"albumart":"https://i.scdn.co/image/ab67616d0000b273d16293a2679483f1416b1d34","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2PCLG4X21rCtq5xK9I2xP7","service":"spop","name":"Sevmek Suçsa Suçluyum","artist":"Melike Şahin","album":"Sevmek Suçsa Suçluyum","type":"song","duration":220,"albumart":"https://i.scdn.co/image/ab67616d0000b2733f33c9eabd42e2f24f9f4c79","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:4T73JmNNhtkFBzjRfCeMzN in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4T73JmNNhtkFBzjRfCeMzN Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:3sgBQybW08n0CzVmkOEtAp in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:3sgBQybW08n0CzVmkOEtAp Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7DCwqBp1HcEHXbwgVrmQxm","service":"spop","name":"Bil Diye Söylüyorum","artist":"Sibel Can","album":"Hayat","type":"song","duration":250,"albumart":"https://i.scdn.co/image/ab67616d0000b273bf161f9047e7ea372672f2cb","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:2fFoXj2aUlaezPp3SinfSD in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:2fFoXj2aUlaezPp3SinfSD Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4HoQXTijn6dVcOxQD3GHRs","service":"spop","name":"Yakışıklı","artist":"KÖFN","album":"Yakışıklı","type":"song","duration":146,"albumart":"https://i.scdn.co/image/ab67616d0000b2732cfd9a483496bc85dad81567","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4xAEqYu3zsb8gcs91ngXUx","service":"spop","name":"Şıkır Şıkır","artist":"Gülben Ergen","album":"Hayat Bi Gün...","type":"song","duration":220,"albumart":"https://i.scdn.co/image/ab67616d0000b2731afbab044d35107714277d36","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:2luWadHsYhuZJF54vw4bTb in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:2luWadHsYhuZJF54vw4bTb Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1eZfubCc0Qf0VgDioyks9j","service":"spop","name":"Misket","artist":"Melis Fis","album":"Misket","type":"song","duration":142,"albumart":"https://i.scdn.co/image/ab67616d0000b2731ec2af7e2e2e43537f2e5670","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:6IXDRacqWKBzee5DgsLRVf in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6IXDRacqWKBzee5DgsLRVf Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:6kbIemHzAcnM60eHdrUI4u in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6kbIemHzAcnM60eHdrUI4u Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4T73JmNNhtkFBzjRfCeMzN","service":"spop","name":"Yansıma","artist":"Derya Uluğ","album":"Nefes","type":"song","duration":173,"albumart":"https://i.scdn.co/image/ab67616d0000b273b1a820a9007bddc84c7d97f4","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3sgBQybW08n0CzVmkOEtAp","service":"spop","name":"Aşkın Ateşi","artist":"Hande Yener","album":"Apayrı","type":"song","duration":232,"albumart":"https://i.scdn.co/image/ab67616d0000b273f93696a7ad36866c1d168b16","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:4UJ3pCmsJORyCa8uO3dklS in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4UJ3pCmsJORyCa8uO3dklS Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:6OodgbaFCaBejPQo4RjOtm in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6OodgbaFCaBejPQo4RjOtm Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2fFoXj2aUlaezPp3SinfSD","service":"spop","name":"Boş Bardak","artist":"Fettah Can","album":"Aklımda Kalanlar","type":"song","duration":226,"albumart":"https://i.scdn.co/image/ab67616d0000b27359c0c2855e0d07d755807d8b","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2luWadHsYhuZJF54vw4bTb","service":"spop","name":"Ne Kavgam Bitti Ne Sevdam","artist":"Gülşen","album":"Yurtta Aşk Cihanda Aşk","type":"song","duration":206,"albumart":"https://i.scdn.co/image/ab67616d0000b2734f806bc070195c0f3c73858b","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:6mlg2VcNguCkGOKQ8AwoQA in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:6mlg2VcNguCkGOKQ8AwoQA Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6IXDRacqWKBzee5DgsLRVf","service":"spop","name":"Sustum","artist":"Evdeki Saat","album":"Sustum","type":"song","duration":212,"albumart":"https://i.scdn.co/image/ab67616d0000b27343ce4b36a07fecd9e45a2f61","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:4OER4Y89FuWMqpALKUMySl in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4OER4Y89FuWMqpALKUMySl Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6kbIemHzAcnM60eHdrUI4u","service":"spop","name":"Düldül","artist":"Mabel Matiz","album":"Fatih","type":"song","duration":265,"albumart":"https://i.scdn.co/image/ab67616d0000b2734868f81271958420add71b28","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:5T4DlSBcqRhKdUljhPFb5D in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:5T4DlSBcqRhKdUljhPFb5D Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:26uHtSrQXUad9uCqxPiIXJ in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:26uHtSrQXUad9uCqxPiIXJ Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4UJ3pCmsJORyCa8uO3dklS","service":"spop","name":"İki Hece","artist":"Berkay","album":"İki Hece","type":"song","duration":213,"albumart":"https://i.scdn.co/image/ab67616d0000b27373ac6471da9ffbb1866b625a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:7zjN55DPbr8CxhfrwqP1qj in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:7zjN55DPbr8CxhfrwqP1qj Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6OodgbaFCaBejPQo4RjOtm","service":"spop","name":"Nanik","artist":"Sezen Aksu","album":"Paşa Gönül Şarkıları","type":"song","duration":151,"albumart":"https://i.scdn.co/image/ab67616d0000b27344a47d5ca77f73be1afe6d96","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:11 volumio volumio[1147]: info: Exploding uri spotify:track:1QuL5ALIuQ6djrKNT7BXy2 in service spop Nov 05 02:18:11 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:1QuL5ALIuQ6djrKNT7BXy2 Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:7ghVCUCGqdIyRfcTZyyxU8 in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:7ghVCUCGqdIyRfcTZyyxU8 Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4OER4Y89FuWMqpALKUMySl","service":"spop","name":"Hayatım Kaymış","artist":"Melek Mosso","album":"Hayatım Kaymış","type":"song","duration":246,"albumart":"https://i.scdn.co/image/ab67616d0000b273750cc07bedaa75b443180380","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6mlg2VcNguCkGOKQ8AwoQA","service":"spop","name":"Sopa - Clup Remix","artist":"Hande Yener","album":"Hande'ye Neler Oluyor","type":"song","duration":243,"albumart":"https://i.scdn.co/image/ab67616d0000b273eefdbc43c2fa7840978d05cd","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5T4DlSBcqRhKdUljhPFb5D","service":"spop","name":"Bi Seni Konuşurum","artist":"Göksel","album":"Arka Bahçem","type":"song","duration":230,"albumart":"https://i.scdn.co/image/ab67616d0000b273c0aeb42f4b7aeb6cf754be49","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:4OjNQv8on0pFfArve1BvTQ in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4OjNQv8on0pFfArve1BvTQ Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:26uHtSrQXUad9uCqxPiIXJ","service":"spop","name":"Tac Mahal","artist":"Buray","album":"Kehanet","type":"song","duration":239,"albumart":"https://i.scdn.co/image/ab67616d0000b2736ae4943df57e3a401be4aaba","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:4zTOUtukd52LzS3bLWwzGc in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:4zTOUtukd52LzS3bLWwzGc Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7zjN55DPbr8CxhfrwqP1qj","service":"spop","name":"Rampapapam","artist":"Arem Ozguc","album":"Rampapapam","type":"song","duration":192,"albumart":"https://i.scdn.co/image/ab67616d0000b273d197aa1058b6ca7391bdf1f7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:7I1HcvlIhaPgN368uSndoc in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:7I1HcvlIhaPgN368uSndoc Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1QuL5ALIuQ6djrKNT7BXy2","service":"spop","name":"Dillere Düşeceğiz Seninle","artist":"Gülşen","album":"Önsöz","type":"song","duration":218,"albumart":"https://i.scdn.co/image/ab67616d0000b273ca279a6c3df9e4db97ee05b8","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:1NRJ9kVLsK3UicyVA2k8bI in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:1NRJ9kVLsK3UicyVA2k8bI Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7ghVCUCGqdIyRfcTZyyxU8","service":"spop","name":"Doktor","artist":"Kenan Doğulu","album":"Aşka Türlü Şeyler","type":"song","duration":212,"albumart":"https://i.scdn.co/image/ab67616d0000b2730288919bb5582eaee60fe937","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:30DEgnb76AxLZgrrvqNErB in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:30DEgnb76AxLZgrrvqNErB Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:track:3rTnSsUS6gD2BDnMlPB2u8 in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:track:3rTnSsUS6gD2BDnMlPB2u8 Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4zTOUtukd52LzS3bLWwzGc","service":"spop","name":"Çingenem","artist":"Ebru Gündeş","album":"Dön Ne Olur","type":"song","duration":190,"albumart":"https://i.scdn.co/image/ab67616d0000b273d385085d0a15c76701fca185","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4OjNQv8on0pFfArve1BvTQ","service":"spop","name":"İsyankar","artist":"Mustafa Sandal","album":"İste","type":"song","duration":235,"albumart":"https://i.scdn.co/image/ab67616d0000b273053ce2a173f105c9197062e6","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:12 volumio volumio[1147]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::ClearQueue Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::stop Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::stPlaybackTimer Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::updateTrackBlock Nov 05 02:18:12 volumio volumio[1147]: info: CorePlayQueue::getTrackBlock Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::pushState Nov 05 02:18:12 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:18:12 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 02:18:12 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::serviceStop Nov 05 02:18:12 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Nov 05 02:18:12 volumio volumio[1147]: info: CoreCommandRouter::serviceStop Nov 05 02:18:12 volumio volumio[1147]: info: [1762298292362] ControllerWebradio::stop Nov 05 02:18:12 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 02:18:12 volumio volumio[1147]: info: CorePlayQueue::clearPlayQueue Nov 05 02:18:12 volumio volumio[1147]: info: CorePlayQueue::saveQueue Nov 05 02:18:12 volumio volumio[1147]: info: CoreCommandRouter::volumioPushQueue Nov 05 02:18:12 volumio volumio[1147]: info: CoreStateMachine::addQueueItems Nov 05 02:18:12 volumio volumio[1147]: info: CorePlayQueue::addQueueItems Nov 05 02:18:12 volumio volumio[1147]: info: Preload queue cleared Nov 05 02:18:12 volumio volumio[1147]: info: Adding Item to queue: spotify:user:spotify:playlist:37i9dQZF1DX5H8QSpChffy Nov 05 02:18:12 volumio volumio[1147]: info: Exploding uri spotify:user:spotify:playlist:37i9dQZF1DX5H8QSpChffy in service spop Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: EXPLODING URI:spotify:user:spotify:playlist:37i9dQZF1DX5H8QSpChffy Nov 05 02:18:12 volumio volumio[1147]: info: [ASDebug] CurState: stop PrevState: play Nov 05 02:18:12 volumio volumio[1147]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Nov 05 02:18:12 volumio volumio[1147]: info: sendMpdCommand stop took 11 milliseconds Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7I1HcvlIhaPgN368uSndoc","service":"spop","name":"Gemiler - Ersay Üner","artist":"Sezen Aksu","album":"Paşa Gönül Şarkıları","type":"song","duration":137,"albumart":"https://i.scdn.co/image/ab67616d0000b27344a47d5ca77f73be1afe6d96","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1NRJ9kVLsK3UicyVA2k8bI","service":"spop","name":"Deli Et Beni","artist":"Harun Kolçak","album":"Çeyrek Asır","type":"song","duration":206,"albumart":"https://i.scdn.co/image/ab67616d0000b273dd55bb46d8f9ba14059def01","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:30DEgnb76AxLZgrrvqNErB","service":"spop","name":"Basit Numaralar","artist":"Zerrin Özer","album":"Basit Numaralar","type":"song","duration":176,"albumart":"https://i.scdn.co/image/ab67616d0000b273b270da567d5ec6bdbf2a5e32","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:12 volumio volumio[1147]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3rTnSsUS6gD2BDnMlPB2u8","service":"spop","name":"Deli Kız","artist":"Buray","album":"Deli Kız","type":"song","duration":195,"albumart":"https://i.scdn.co/image/ab67616d0000b273764e8ea200765ac5128e88a1","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Nov 05 02:18:13 volumio volumio[1147]: info: [ASDebug] Togle GPIO: OFF Nov 05 02:18:13 volumio volumio[1147]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 02:18:13 volumio volumio[1147]: Error: ESPIPE: invalid seek, write Nov 05 02:18:13 volumio volumio[1147]: at Object.writeSync (fs.js:711:3) Nov 05 02:18:13 volumio volumio[1147]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Nov 05 02:18:13 volumio volumio[1147]: at AmpSwitchController.off (/data/plugins/system_controller/ampswitch/index.js:221:23) Nov 05 02:18:13 volumio volumio[1147]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:195:88) Nov 05 02:18:13 volumio volumio[1147]: at listOnTimeout (internal/timers.js:554:17) Nov 05 02:18:13 volumio volumio[1147]: at processTimers (internal/timers.js:497:7) { Nov 05 02:18:13 volumio volumio[1147]: errno: -29, Nov 05 02:18:13 volumio volumio[1147]: syscall: 'write', Nov 05 02:18:13 volumio volumio[1147]: code: 'ESPIPE' Nov 05 02:18:13 volumio volumio[1147]: } Nov 05 02:18:13 volumio volumio[1147]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 02:18:13 volumio sudo[3435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-05 02:17 Nov 05 02:18:13 volumio sudo[3435]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"