-- Logs begin at Thu 2019-02-14 08:12:00 -02, end at Wed 2025-07-09 19:03:18 -03. --
Jul 09 19:02:05 volumio volumio[825]: info: Checking if install.sh is present
Jul 09 19:02:05 volumio volumio[825]: info: Executing install.sh
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 8
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 9
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 10
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 11
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 12
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 13
Jul 09 19:02:05 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 14
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 15
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 16
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 17
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 18
Jul 09 19:02:06 volumio sudo[7257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/gpio_control/install.sh
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 19
Jul 09 19:02:06 volumio sudo[7257]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 20
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 21
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 22
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 23
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 24
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 25
Jul 09 19:02:06 volumio sudo[7259]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 26
Jul 09 19:02:06 volumio sudo[7259]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 27
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 28
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 29
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 30
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 31
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 32
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 33
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 34
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 35
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 36
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 37
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 38
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 39
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 40
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 41
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 42
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 43
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 44
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 45
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.15.16 from 192.168.15.14 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 46
Jul 09 19:02:06 volumio volumio[825]: info: CoreCommandRouter::volumioGetState
Jul 09 19:02:06 volumio volumio[825]: info: CorePlayQueue::getTrack 1
Jul 09 19:02:06 volumio volumio[825]: info: Installing gpio control Dependencies
Jul 09 19:02:06 volumio volumio[825]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 19:02:06 volumio volumio[825]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 19:02:06 volumio volumio[825]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 19:02:06 volumio volumio[825]: info: Listing playlists
Jul 09 19:02:06 volumio volumio[825]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 47
Jul 09 19:02:07 volumio volumio[825]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease
Jul 09 19:02:07 volumio volumio[825]: info: Get:2 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB]
Jul 09 19:02:07 volumio volumio[825]: info: Get:3 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB]
Jul 09 19:02:08 volumio go-librespot[1135]: time="2025-07-09T19:02:08-03:00" level=trace msg="sent dealer ping"
Jul 09 19:02:08 volumio go-librespot[1135]: time="2025-07-09T19:02:08-03:00" level=trace msg="received dealer pong"
Jul 09 19:02:11 volumio volumio[825]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB]
Jul 09 19:02:12 volumio volumio[825]: info: Fetched 470 kB in 5s (91.0 kB/s)
Jul 09 19:02:17 volumio volumio[825]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio_control/volumio/buster/armhf
Jul 09 19:02:21 volumio volumio[825]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio_control/volumio/buster/armhf
Jul 09 19:02:21 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:02:21 volumio volumio[825]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio_control/volumio/buster/armhf
Jul 09 19:02:24 volumio volumio[825]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ir_controller/volumio/buster/armhf
Jul 09 19:02:26 volumio volumio[825]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ir_controller/volumio/buster/armhf
Jul 09 19:02:32 volumio volumio[825]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf
Jul 09 19:02:34 volumio volumio[825]: info: Reading package lists...
Jul 09 19:02:34 volumio volumio[825]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf
Jul 09 19:02:35 volumio volumio[825]: info: CorePlayQueue::getTrack 1
Jul 09 19:02:35 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:02:35 volumio volumio[825]: info: Prefetching next song
Jul 09 19:02:35 volumio volumio[825]: info: [1752098555761] ControllerSpotify::prefetch
Jul 09 19:02:35 volumio volumio[825]: info: Sending Spotify command with payload to local API: /player/add_to_queue
Jul 09 19:02:38 volumio go-librespot[1135]: time="2025-07-09T19:02:38-03:00" level=trace msg="received accesspoint ping"
Jul 09 19:02:38 volumio go-librespot[1135]: time="2025-07-09T19:02:38-03:00" level=trace msg="received accesspoint pong ack"
Jul 09 19:02:38 volumio go-librespot[1135]: time="2025-07-09T19:02:38-03:00" level=trace msg="sent dealer ping"
Jul 09 19:02:38 volumio go-librespot[1135]: time="2025-07-09T19:02:38-03:00" level=trace msg="received dealer pong"
Jul 09 19:02:39 volumio mpd_monitor.sh[551]: MPD Monitor Service: MPD Appears to be inactive, restarting
Jul 09 19:02:40 volumio volumio[825]: info: CoreStateMachine::startPlaybackTimer
Jul 09 19:02:40 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:02:40 volumio volumio[825]: info: CoreStateMachine::pushState
Jul 09 19:02:40 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:02:40 volumio volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 19:02:40 volumio volumio[825]: info: CoreCommandRouter::volumioPushState
Jul 09 19:02:41 volumio go-librespot[1135]: time="2025-07-09T19:02:41-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 19:02:43 volumio volumio[825]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Jul 09 19:02:43 volumio volumio[825]: info: [ASDebug] CurState: play PrevState: play
Jul 09 19:02:44 volumio volumio[825]: info: Check plugin dependencies
Jul 09 19:02:45 volumio go-librespot[1135]: time="2025-07-09T19:02:45-03:00" level=debug msg="prefetching next track" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:45 volumio go-librespot[1135]: time="2025-07-09T19:02:45-03:00" level=debug msg="selected format OGG_VORBIS_320 (611fadcb5d7abc07eb89efbb18a6206b377cae57)" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:45 volumio go-librespot[1135]: time="2025-07-09T19:02:45-03:00" level=debug msg="requested aes key for file 611fadcb5d7abc07eb89efbb18a6206b377cae57, gid: 1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:45 volumio volumio[825]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 09 19:02:45 volumio volumio[825]: info: Checking if plugin already exists
Jul 09 19:02:45 volumio sudo[7259]: pam_unix(sudo:session): session closed for user root
Jul 09 19:02:45 volumio systemd[1]: Stopping Music Player Daemon...
Jul 09 19:02:46 volumio volumio[825]: info: Rename folder
Jul 09 19:02:46 volumio go-librespot[1135]: time="2025-07-09T19:02:46-03:00" level=debug msg="fetched first chunk of 23, total size is 11986820 bytes" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:46 volumio go-librespot[1135]: time="2025-07-09T19:02:46-03:00" level=info msg="prefetched track \"Step Into Light\" (duration: 296453ms)" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:46 volumio go-librespot[1135]: time="2025-07-09T19:02:46-03:00" level=debug msg="fetched chunk 2/22, size: 524288" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:46 volumio volumio[825]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 19:02:46 volumio sudo[7578]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install
Jul 09 19:02:46 volumio sudo[7578]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:02:46 volumio go-librespot[1135]: time="2025-07-09T19:02:46-03:00" level=debug msg="fetched chunk 1/22, size: 524288" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:46 volumio volumio[825]: info: Move to category
Jul 09 19:02:46 volumio go-librespot[1135]: time="2025-07-09T19:02:46-03:00" level=debug msg="fetched chunk 3/22, size: 524288" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:47 volumio volumio[825]: info: Reading package lists...
Jul 09 19:02:47 volumio sudo[7585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 09 19:02:47 volumio sudo[7585]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:02:47 volumio sudo[7585]: pam_unix(sudo:session): session closed for user root
Jul 09 19:02:47 volumio sudo[7587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 09 19:02:47 volumio sudo[7587]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:02:47 volumio sudo[7587]: pam_unix(sudo:session): session closed for user root
Jul 09 19:02:48 volumio volumio[825]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.109 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 OPR/119.0.0.0 (Edition std-1) Engine version: 3 Transport: polling Total Clients: 9
Jul 09 19:02:48 volumio volumio[825]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ir_controller/volumio/buster/armhf
Jul 09 19:02:48 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:02:48 volumio volumio[825]: info: An error occurred installing the plugin. Rolling back config
Jul 09 19:02:48 volumio volumio[825]: info: Plugin folders cleanup
Jul 09 19:02:48 volumio volumio[825]: info: Scanning into folder /volumio/app/plugins/
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category audio_interface
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category miscellanea
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category plugins.json
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:02:54 volumio volumio[825]: info: Scanning into folder /data/plugins/
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category gpio_control
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/UIConfig.json
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/config.json
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/gitignore
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/index.js
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/install.sh
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/json
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/package-lock.json
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/package.json
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/readme.md
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/requiredConf.json
Jul 09 19:02:54 volumio volumio[825]: info: Removing /data/plugins//gpio_control/uninstall.sh
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category system_hardware
Jul 09 19:02:54 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:02:54 volumio volumio[825]: info: Plugin folders cleanup completed
Jul 09 19:02:54 volumio volumio[825]: info: Error: Error
Jul 09 19:02:55 volumio volumio[825]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 19:02:55 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:02:55 volumio volumio[825]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 19:02:55 volumio go-librespot[1135]: time="2025-07-09T19:02:55-03:00" level=trace msg="emitting websocket event: not_playing"
Jul 09 19:02:55 volumio go-librespot[1135]: time="2025-07-09T19:02:55-03:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:55 volumio go-librespot[1135]: time="2025-07-09T19:02:55-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 19:02:55 volumio go-librespot[1135]: time="2025-07-09T19:02:55-03:00" level=trace msg="emitting websocket event: will_play"
Jul 09 19:02:55 volumio go-librespot[1135]: time="2025-07-09T19:02:55-03:00" level=info msg="loaded track \"Step Into Light\" (paused: false, position: 0ms, duration: 296453ms, prefetched: true)" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:02:56 volumio go-librespot[1135]: time="2025-07-09T19:02:56-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 19:02:56 volumio go-librespot[1135]: time="2025-07-09T19:02:56-03:00" level=trace msg="scheduling prefetch in 266s"
Jul 09 19:02:56 volumio go-librespot[1135]: time="2025-07-09T19:02:56-03:00" level=trace msg="emitting websocket event: metadata"
Jul 09 19:02:56 volumio go-librespot[1135]: time="2025-07-09T19:02:56-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 19:02:56 volumio go-librespot[1135]: time="2025-07-09T19:02:56-03:00" level=trace msg="emitting websocket event: playing"
Jul 09 19:03:07 volumio volumio[825]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ir_controller/volumio/buster/armhf
Jul 09 19:03:07 volumio volumio[825]: info: Building dependency tree...
Jul 09 19:03:07 volumio volumio[825]: info: Reading state information...
Jul 09 19:03:07 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:03:07 volumio volumio[825]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:7pOCZihX7eBsg9TBpZTP7G","play_origin":"go-librespot"}}
Jul 09 19:03:07 volumio volumio[825]: error: Failed to decode event: not_playing
Jul 09 19:03:07 volumio volumio[825]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","play_origin":"go-librespot"}}
Jul 09 19:03:07 volumio volumio[825]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","name":"Step Into Light","artist_names":["Volbeat"],"album_name":"Servant Of The Mind (Deluxe)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02108d3b26e2c2fd86c6c1b7ec","position":0,"duration":296453,"release_date":"year:2021 month:12 day:3","track_number":10,"disc_number":1}}
Jul 09 19:03:07 volumio volumio[825]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","play_origin":"go-librespot"}}
Jul 09 19:03:07 volumio volumio[825]: SPOTIFY: PUSH STATE SPOTIFY
Jul 09 19:03:07 volumio volumio[825]: SPOTIFY: {"status":"play","service":"spop","title":"Step Into Light","artist":"Volbeat","album":"Servant Of The Mind (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02108d3b26e2c2fd86c6c1b7ec","uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","trackType":"spotify","seek":0,"duration":296,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jul 09 19:03:07 volumio volumio[825]: info: CoreCommandRouter::servicePushState
Jul 09 19:03:07 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:03:07 volumio volumio[825]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Step Into Light","artist":"Volbeat","album":"Servant Of The Mind (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02108d3b26e2c2fd86c6c1b7ec","uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","trackType":"spotify","seek":0,"duration":296,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jul 09 19:03:07 volumio volumio[825]: verbose: CURRENT POSITION 2
Jul 09 19:03:07 volumio volumio[825]: info: CoreStateMachine::syncState stateService play
Jul 09 19:03:07 volumio volumio[825]: info: CoreStateMachine::syncState currentStatus play
Jul 09 19:03:07 volumio volumio[825]: info: Received an update from plugin. extracting info from payload
Jul 09 19:03:07 volumio volumio[825]: info: CoreStateMachine::pushState
Jul 09 19:03:07 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:03:07 volumio volumio[825]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 19:03:07 volumio volumio[825]: info: CoreCommandRouter::volumioPushState
Jul 09 19:03:07 volumio volumio[825]: info: CoreStateMachine::pushState
Jul 09 19:03:07 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:03:07 volumio volumio[825]: info: CoreCommandRouter::volumioPushState
Jul 09 19:03:08 volumio go-librespot[1135]: time="2025-07-09T19:03:08-03:00" level=debug msg="fetched chunk 4/22, size: 524288" uri="spotify:track:1yxnTcmWQrNXN3HAqCAOrV"
Jul 09 19:03:08 volumio volumio[825]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jul 09 19:03:08 volumio volumio[825]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jul 09 19:03:08 volumio volumio[825]: SPOTIFY: PUSH STATE SPOTIFY
Jul 09 19:03:08 volumio volumio[825]: SPOTIFY: {"status":"play","service":"spop","title":"Step Into Light","artist":"Volbeat","album":"Servant Of The Mind (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02108d3b26e2c2fd86c6c1b7ec","uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","trackType":"spotify","seek":0,"duration":296,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jul 09 19:03:08 volumio volumio[825]: info: CoreCommandRouter::servicePushState
Jul 09 19:03:08 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:03:08 volumio volumio[825]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Step Into Light","artist":"Volbeat","album":"Servant Of The Mind (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02108d3b26e2c2fd86c6c1b7ec","uri":"spotify:track:1yxnTcmWQrNXN3HAqCAOrV","trackType":"spotify","seek":0,"duration":296,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null}
Jul 09 19:03:08 volumio volumio[825]: verbose: CURRENT POSITION 2
Jul 09 19:03:08 volumio volumio[825]: info: CoreStateMachine::syncState stateService play
Jul 09 19:03:08 volumio volumio[825]: info: CoreStateMachine::syncState currentStatus play
Jul 09 19:03:08 volumio volumio[825]: info: Received an update from plugin. extracting info from payload
Jul 09 19:03:08 volumio volumio[825]: info: CoreStateMachine::pushState
Jul 09 19:03:08 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:03:08 volumio volumio[825]: info: CoreCommandRouter::volumioPushState
Jul 09 19:03:08 volumio volumio[825]: info: CoreStateMachine::pushState
Jul 09 19:03:08 volumio volumio[825]: info: CorePlayQueue::getTrack 2
Jul 09 19:03:08 volumio volumio[825]: info: CoreCommandRouter::volumioPushState
Jul 09 19:03:08 volumio volumio[825]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf
Jul 09 19:03:08 volumio volumio[825]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf
Jul 09 19:03:08 volumio go-librespot[1135]: time="2025-07-09T19:03:08-03:00" level=trace msg="sent dealer ping"
Jul 09 19:03:08 volumio go-librespot[1135]: time="2025-07-09T19:03:08-03:00" level=trace msg="received dealer pong"
Jul 09 19:03:09 volumio wpa_supplicant[4231]: wlan0: CTRL-EVENT-BEACON-LOSS
Jul 09 19:03:09 volumio systemd[1]: mpd.service: Succeeded.
Jul 09 19:03:09 volumio systemd[1]: Stopped Music Player Daemon.
Jul 09 19:03:09 volumio systemd[1]: Starting Music Player Daemon...
Jul 09 19:03:09 volumio volumio[825]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jul 09 19:03:10 volumio volumio[825]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio_control/volumio/buster/armhf
Jul 09 19:03:10 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:03:10 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:03:10 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:03:11 volumio volumio[825]: info: An error occurred installing the plugin. Rolling back config
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /volumio/app/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category audio_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category miscellanea
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category plugins.json
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /data/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category gpio_control
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_hardware
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup completed
Jul 09 19:03:11 volumio volumio[825]: info: Error: Error
Jul 09 19:03:11 volumio volumio[825]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 19:03:11 volumio volumio[825]: info: Folder /tmp/plugins removed
Jul 09 19:03:11 volumio volumio[825]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 19:03:11 volumio volumio[825]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jul 09 19:03:11 volumio volumio[825]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jul 09 19:03:11 volumio volumio[825]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Jul 09 19:03:11 volumio sudo[7578]: pam_unix(sudo:session): session closed for user root
Jul 09 19:03:11 volumio volumio[825]: info: An error occurred installing the plugin. Rolling back config
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /volumio/app/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category audio_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category miscellanea
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category plugins.json
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /data/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category gpio_control
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_hardware
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup completed
Jul 09 19:03:11 volumio volumio[825]: info: Error: Error
Jul 09 19:03:11 volumio volumio[825]: info: An error occurred installing the plugin. Rolling back config
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /volumio/app/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category audio_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category miscellanea
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category plugins.json
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /data/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category gpio_control
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_hardware
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup completed
Jul 09 19:03:11 volumio volumio[825]: info: Error: Error
Jul 09 19:03:11 volumio volumio[825]: info: An error occurred installing the plugin. Rolling back config
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /volumio/app/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category audio_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category miscellanea
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category plugins.json
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Scanning into folder /data/plugins/
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category gpio_control
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category music_service
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_controller
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category system_hardware
Jul 09 19:03:11 volumio volumio[825]: info: Scanning category user_interface
Jul 09 19:03:11 volumio volumio[825]: info: Plugin folders cleanup completed
Jul 09 19:03:11 volumio volumio[825]: info: Error: Error
Jul 09 19:03:11 volumio volumio[825]: info: Folder /data/temp removed
Jul 09 19:03:11 volumio sudo[7257]: pam_unix(sudo:session): session closed for user root
Jul 09 19:03:12 volumio volumio[825]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 19:03:12 volumio volumio[825]: Error: Unable to resolve or reject the same promise twice
Jul 09 19:03:12 volumio volumio[825]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Jul 09 19:03:12 volumio volumio[825]: at /volumio/app/pluginmanager.js:1087:11
Jul 09 19:03:12 volumio volumio[825]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Jul 09 19:03:12 volumio volumio[825]: at FSReqCallback.oncomplete (fs.js:171:23)
Jul 09 19:03:12 volumio volumio[825]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 19:03:13 volumio sudo[7625]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 09 19:03:13 volumio sudo[7625]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:03:13 volumio sudo[7625]: pam_unix(sudo:session): session closed for user root
Jul 09 19:03:18 volumio mpd[7678]: Jul 09 19:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 09 19:03:18 volumio sudo[7701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 19:02
Jul 09 19:03:18 volumio sudo[7701]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 19:03:18 volumio systemd[1]: Started Music Player Daemon.
Jul 09 19:03:18 volumio mpd_monitor.sh[551]: MPD Monitor Service: MPD restarted due to no mpc output.
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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"