-- Logs begin at Thu 2025-11-27 02:10:00 UTC, end at Sun 2025-12-07 00:08:46 UTC. --
Dec 07 00:07:00 volumio volumio[1149]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json
Dec 07 00:08:00 volumio volumio[1149]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio_control/volumio/buster/armhf
Dec 07 00:08:04 volumio volumio[1149]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio_control/volumio/buster/armhf
Dec 07 00:08:04 volumio volumio[1149]: info: Folder /tmp/plugins removed
Dec 07 00:08:04 volumio volumio[1149]: info: Check plugin dependencies
Dec 07 00:08:04 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 07 00:08:04 volumio volumio[1149]: info: Checking if plugin already exists
Dec 07 00:08:04 volumio volumio[1149]: info: Rename folder
Dec 07 00:08:04 volumio volumio[1149]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 07 00:08:04 volumio volumio[1149]: info: Move to category
Dec 07 00:08:07 volumio volumio[1149]: info: Checking if install.sh is present
Dec 07 00:08:07 volumio volumio[1149]: info: Executing install.sh
Dec 07 00:08:07 volumio sudo[25834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/gpio_control/install.sh
Dec 07 00:08:07 volumio sudo[25834]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 07 00:08:07 volumio volumio[1149]: info: Installing gpio control Dependencies
Dec 07 00:08:07 volumio sudo[25838]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update
Dec 07 00:08:07 volumio sudo[25838]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 07 00:08:08 volumio volumio[1149]: info: Get:1 https://deb.nodesource.com/node_14.x buster InRelease [4584 B]
Dec 07 00:08:08 volumio volumio[1149]: info: Ign:2 http://raspbian.raspberrypi.org/raspbian buster InRelease
Dec 07 00:08:08 volumio volumio[1149]: info: Hit:3 http://archive.raspberrypi.org/debian buster InRelease
Dec 07 00:08:08 volumio volumio[1149]: info: Err:4 http://raspbian.raspberrypi.org/raspbian buster Release
Dec 07 00:08:08 volumio volumio[1149]: info: 404 Not Found [IP: 93.93.128.193 80]
Dec 07 00:08:12 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 07 00:08:12 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 07 00:08:12 volumio volumio[1149]: info: Discovery: Getting this device information
Dec 07 00:08:12 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState
Dec 07 00:08:12 volumio volumio[1149]: info: CorePlayQueue::getTrack 2
Dec 07 00:08:12 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 07 00:08:12 volumio volumio[1149]: verbose: New Socket.io Connection to 192.168.1.74:3000 from 192.168.1.73 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Dec 07 00:08:12 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 07 00:08:12 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 07 00:08:13 volumio volumio[1149]: info: Reading package lists...
Dec 07 00:08:13 volumio sudo[25838]: pam_unix(sudo:session): session closed for user root
Dec 07 00:08:13 volumio sudo[25991]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install
Dec 07 00:08:13 volumio sudo[25991]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 07 00:08:13 volumio volumio[1149]: info: Reading package lists...
Dec 07 00:08:14 volumio volumio[1149]: info: Building dependency tree...
Dec 07 00:08:14 volumio volumio[1149]: info: Reading state information...
Dec 07 00:08:16 volumio volumio[1149]: info: 0 upgraded, 0 newly installed, 0 to remove and 167 not upgraded.
Dec 07 00:08:16 volumio sudo[25991]: pam_unix(sudo:session): session closed for user root
Dec 07 00:08:16 volumio sudo[25834]: pam_unix(sudo:session): session closed for user root
Dec 07 00:08:16 volumio volumio[1149]: info: Installing gpio_control
Dec 07 00:08:16 volumio volumio[1149]: Plugin install end detected on script
Dec 07 00:08:16 volumio volumio[1149]: info: Install script completed
Dec 07 00:08:16 volumio volumio[1149]: info: Adding reference to registry
Dec 07 00:08:16 volumio volumio[1149]: info: Done installing plugin.
Dec 07 00:08:16 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 07 00:08:16 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 07 00:08:16 volumio volumio[1149]: info: Folder /tmp/plugins removed
Dec 07 00:08:16 volumio volumio[1149]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 07 00:08:16 volumio volumio[1149]: info: Folder /data/temp removed
Dec 07 00:08:16 volumio volumio[1149]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 07 00:08:16 volumio volumio[1149]: info: FusionDsp -
Dec 07 00:08:16 volumio volumio[1149]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json
Dec 07 00:08:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 2
Dec 07 00:08:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 0
Dec 07 00:08:20 volumio volumio[1149]: info: Prefetching next song
Dec 07 00:08:20 volumio volumio[1149]: info: DOING PREFETCH IN MPD
Dec 07 00:08:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand add "USB/New_Volume/Music/Julia Jacklin - Crushing [FLAC]/01 - Body.flac"
Dec 07 00:08:20 volumio volumio[1149]: info:
Dec 07 00:08:20 volumio volumio[1149]: ---------------------------- MPD announces system playlist update
Dec 07 00:08:20 volumio volumio[1149]: info: Ignoring MPD Status Update
Dec 07 00:08:20 volumio volumio[1149]: info: sendMpdCommand add "USB/New_Volume/Music/Julia Jacklin - Crushing [FLAC]/01 - Body.flac" took 2 milliseconds
Dec 07 00:08:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand consume 1
Dec 07 00:08:20 volumio volumio[1149]: info:
Dec 07 00:08:20 volumio volumio[1149]: ---------------------------- MPD announces state update: options
Dec 07 00:08:20 volumio volumio[1149]: info: ------------------------------ 3ms
Dec 07 00:08:20 volumio volumio[1149]: info: sendMpdCommand consume 1 took 2 milliseconds
Dec 07 00:08:20 volumio volumio[1149]: info: ControllerMpd::getState
Dec 07 00:08:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand status
Dec 07 00:08:20 volumio volumio[1149]: info: sendMpdCommand status took 1 milliseconds
Dec 07 00:08:20 volumio volumio[1149]: verbose: ControllerMpd::parseState
Dec 07 00:08:20 volumio volumio[1149]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 07 00:08:20 volumio volumio[1149]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 07 00:08:20 volumio volumio[1149]: verbose: ControllerMpd::parseTrackInfo
Dec 07 00:08:20 volumio volumio[1149]: info: ControllerMpd::pushState
Dec 07 00:08:20 volumio volumio[1149]: info: CoreCommandRouter::servicePushState
Dec 07 00:08:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 2
Dec 07 00:08:20 volumio volumio[1149]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42968,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"Pressure to Party","artist":"Julia Jacklin","album":"Crushing","uri":"USB/New_Volume/Music/Julia Jacklin - Crushing [FLAC]/03 - Pressure to Party.flac","trackType":"flac"}
Dec 07 00:08:20 volumio volumio[1149]: verbose: CURRENT POSITION 2
Dec 07 00:08:20 volumio volumio[1149]: info: CoreStateMachine::syncState stateService play
Dec 07 00:08:20 volumio volumio[1149]: info: CoreStateMachine::syncState currentStatus play
Dec 07 00:08:20 volumio volumio[1149]: info: Received an update from plugin. extracting info from payload
Dec 07 00:08:20 volumio volumio[1149]: info: CoreStateMachine::pushState
Dec 07 00:08:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 2
Dec 07 00:08:20 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 07 00:08:20 volumio volumio[1149]: info: CoreCommandRouter::volumioPushState
Dec 07 00:08:20 volumio volumio[1149]: info: CoreStateMachine::pushState
Dec 07 00:08:20 volumio volumio[1149]: info: CorePlayQueue::getTrack 2
Dec 07 00:08:20 volumio volumio[1149]: info: CoreCommandRouter::volumioPushState
Dec 07 00:08:20 volumio volumio[1149]: info: ------------------------------ 16ms
Dec 07 00:08:21 volumio volumio[1149]: info: Enabling plugin gpio_control
Dec 07 00:08:21 volumio volumio[1149]: info: Loading plugin "gpio_control"...
Dec 07 00:08:25 volumio volumio[1149]: gpiox_arm32 V2.1.0
Dec 07 00:08:26 volumio volumio[1149]: info: PLUGIN START: gpio_control
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Reading config and creating GPIOs
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] GPIOs created
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Handling event: systemStartup
Dec 07 00:08:26 volumio volumio[1149]: info: Done.
Dec 07 00:08:26 volumio volumio[1149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 07 00:08:26 volumio volumio[1149]: Upnp client error: Error: This socket has been ended by the other party
Dec 07 00:08:26 volumio volumio[1149]: Upnp client error: Error: This socket has been ended by the other party
Dec 07 00:08:26 volumio volumio[1149]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Dec 07 00:08:26 volumio volumio[1149]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 07 00:08:26 volumio volumio[1149]: info: CoreCommandRouter::volumioGetState
Dec 07 00:08:26 volumio volumio[1149]: info: CorePlayQueue::getTrack 2
Dec 07 00:08:26 volumio volumio[1149]: info: FusionDsp -
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Status changed: play
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Handling event: musicPlay
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Handling event: randomOn
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Handling event: repeatOn
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Handling event: repeatAllOn
Dec 07 00:08:26 volumio volumio[1149]: info: [GPIO_Control] Status changed: play
Dec 07 00:08:26 volumio volumio[1149]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json
Dec 07 00:08:42 volumio volumio[1149]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 07 00:08:45 volumio volumio[1149]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 07 00:08:45 volumio volumio[1149]: info: FusionDsp - Stopping FusionDsp service
Dec 07 00:08:45 volumio volumio[1149]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 07 00:08:45 volumio volumio[1149]: TypeError: Cannot read property 'stop' of null
Dec 07 00:08:45 volumio volumio[1149]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23)
Dec 07 00:08:45 volumio volumio[1149]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Dec 07 00:08:45 volumio volumio[1149]: at /volumio/app/pluginmanager.js:956:12
Dec 07 00:08:45 volumio volumio[1149]: at ChildProcess.exithandler (child_process.js:299:7)
Dec 07 00:08:45 volumio volumio[1149]: at ChildProcess.emit (events.js:315:20)
Dec 07 00:08:45 volumio volumio[1149]: at maybeClose (internal/child_process.js:1048:16)
Dec 07 00:08:45 volumio volumio[1149]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5)
Dec 07 00:08:45 volumio volumio[1149]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 07 00:08:46 volumio sudo[26159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-07 00:07
Dec 07 00:08:46 volumio sudo[26159]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"