-- Logs begin at Tue 2025-06-17 13:06:12 -04, end at Tue 2025-06-17 13:17:16 -04. --
Jun 17 13:16:03 volumio volumio[898]: info: CALLMETHOD: system_controller ampswitch saveOptions [object Object]
Jun 17 13:16:03 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: ampswitch , saveOptions
Jun 17 13:16:03 volumio volumio[898]: info: [ASDebug] Saving Settings: Port: 27
Jun 17 13:16:03 volumio volumio[898]: info: [ASDebug] Saving Settings: Inverted: true
Jun 17 13:16:03 volumio volumio[898]: info: [ASDebug] Saving Settings: Delay: 720
Jun 17 13:16:03 volumio volumio[898]: info: [ASDebug] Saving Settings: Latched: false
Jun 17 13:16:03 volumio volumio[898]: info: [ASDebug] Saving Settings: On Pulse width: 500
Jun 17 13:16:03 volumio volumio[898]: info: [ASDebug] Saving Settings: Off Pulse width: 500
Jun 17 13:16:14 volumio sshd[2101]: Did not receive identification string from 192.168.1.47 port 47354
Jun 17 13:16:15 volumio sshd[1882]: Received disconnect from 192.168.1.47 port 47246:11:
Jun 17 13:16:15 volumio sshd[1882]: Disconnected from user volumio 192.168.1.47 port 47246
Jun 17 13:16:15 volumio sshd[1854]: pam_unix(sshd:session): session closed for user volumio
Jun 17 13:16:15 volumio systemd-logind[294]: Session 6 logged out. Waiting for processes to exit.
Jun 17 13:16:15 volumio systemd[1]: session-6.scope: Succeeded.
Jun 17 13:16:15 volumio systemd-logind[294]: Removed session 6.
Jun 17 13:16:25 volumio systemd[1]: Stopping User Manager for UID 1000...
Jun 17 13:16:25 volumio systemd[1859]: Stopped target Default.
Jun 17 13:16:25 volumio systemd[1859]: Stopped target Basic System.
Jun 17 13:16:25 volumio systemd[1859]: Stopped target Sockets.
Jun 17 13:16:25 volumio systemd[1859]: dbus.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed D-Bus User Message Bus Socket.
Jun 17 13:16:25 volumio systemd[1859]: gpg-agent-ssh.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Jun 17 13:16:25 volumio systemd[1859]: gpg-agent.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed GnuPG cryptographic agent and passphrase cache.
Jun 17 13:16:25 volumio systemd[1859]: dirmngr.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed GnuPG network certificate management daemon.
Jun 17 13:16:25 volumio systemd[1859]: gpg-agent-extra.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Jun 17 13:16:25 volumio systemd[1859]: Stopped target Paths.
Jun 17 13:16:25 volumio systemd[1859]: Stopped target Timers.
Jun 17 13:16:25 volumio systemd[1859]: pulseaudio.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed Sound System.
Jun 17 13:16:25 volumio systemd[1859]: gpg-agent-browser.socket: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jun 17 13:16:25 volumio systemd[1859]: Reached target Shutdown.
Jun 17 13:16:25 volumio systemd[1859]: systemd-exit.service: Succeeded.
Jun 17 13:16:25 volumio systemd[1859]: Started Exit the Session.
Jun 17 13:16:25 volumio systemd[1859]: Reached target Exit the Session.
Jun 17 13:16:25 volumio systemd[1]: user@1000.service: Succeeded.
Jun 17 13:16:25 volumio systemd[1]: Stopped User Manager for UID 1000.
Jun 17 13:16:25 volumio systemd[1]: Stopping User Runtime Directory /run/user/1000...
Jun 17 13:16:26 volumio systemd[1]: run-user-1000.mount: Succeeded.
Jun 17 13:16:26 volumio systemd[1]: user-runtime-dir@1000.service: Succeeded.
Jun 17 13:16:26 volumio systemd[1]: Stopped User Runtime Directory /run/user/1000.
Jun 17 13:16:26 volumio systemd[1]: Removed slice User Slice of UID 1000.
Jun 17 13:16:31 volumio volumio[898]: info: CALLMETHOD: system_controller ampswitch saveOptions [object Object]
Jun 17 13:16:31 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: ampswitch , saveOptions
Jun 17 13:16:31 volumio volumio[898]: info: [ASDebug] Saving Settings: Port: 26
Jun 17 13:16:31 volumio volumio[898]: info: [ASDebug] Saving Settings: Inverted: true
Jun 17 13:16:31 volumio volumio[898]: info: [ASDebug] Saving Settings: Delay: 720
Jun 17 13:16:31 volumio volumio[898]: info: [ASDebug] Saving Settings: Latched: false
Jun 17 13:16:31 volumio volumio[898]: info: [ASDebug] Saving Settings: On Pulse width: 500
Jun 17 13:16:31 volumio volumio[898]: info: [ASDebug] Saving Settings: Off Pulse width: 500
Jun 17 13:16:49 volumio volumio[898]: info: CALLMETHOD: system_controller ampswitch saveOptions [object Object]
Jun 17 13:16:49 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: ampswitch , saveOptions
Jun 17 13:16:49 volumio volumio[898]: info: [ASDebug] Saving Settings: Port: 26
Jun 17 13:16:49 volumio volumio[898]: info: [ASDebug] Saving Settings: Inverted: true
Jun 17 13:16:49 volumio volumio[898]: info: [ASDebug] Saving Settings: Delay: 720
Jun 17 13:16:49 volumio volumio[898]: info: [ASDebug] Saving Settings: Latched: true
Jun 17 13:16:49 volumio volumio[898]: info: [ASDebug] Saving Settings: On Pulse width: 500
Jun 17 13:16:49 volumio volumio[898]: info: [ASDebug] Saving Settings: Off Pulse width: 500
Jun 17 13:16:54 volumio volumio[898]: info: CALLMETHOD: system_controller ampswitch saveOptions [object Object]
Jun 17 13:16:54 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: ampswitch , saveOptions
Jun 17 13:16:54 volumio volumio[898]: info: [ASDebug] Saving Settings: Port: 26
Jun 17 13:16:54 volumio volumio[898]: info: [ASDebug] Saving Settings: Inverted: true
Jun 17 13:16:54 volumio volumio[898]: info: [ASDebug] Saving Settings: Delay: 720
Jun 17 13:16:54 volumio volumio[898]: info: [ASDebug] Saving Settings: Latched: false
Jun 17 13:16:54 volumio volumio[898]: info: [ASDebug] Saving Settings: On Pulse width: 500
Jun 17 13:16:54 volumio volumio[898]: info: [ASDebug] Saving Settings: Off Pulse width: 500
Jun 17 13:17:02 volumio volumio[898]: info: CoreCommandRouter::volumioGetState
Jun 17 13:17:02 volumio volumio[898]: info: CorePlayQueue::getTrack 2
Jun 17 13:17:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 17 13:17:05 volumio volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 17 13:17:08 volumio volumio[898]: info: [ASDebug] Port: 26
Jun 17 13:17:08 volumio volumio[898]: info: [ASDebug] Inverted: true
Jun 17 13:17:08 volumio volumio[898]: info: [ASDebug] Delay: 720
Jun 17 13:17:14 volumio volumio[898]: info: [ASDebug] Port: 26
Jun 17 13:17:14 volumio volumio[898]: info: [ASDebug] Inverted: true
Jun 17 13:17:14 volumio volumio[898]: info: [ASDebug] Delay: 720
Jun 17 13:17:14 volumio volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 17 13:17:14 volumio volumio[898]: Error: EBADF: bad file descriptor, close
Jun 17 13:17:14 volumio volumio[898]: at Object.closeSync (fs.js:439:3)
Jun 17 13:17:14 volumio volumio[898]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20)
Jun 17 13:17:14 volumio volumio[898]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27)
Jun 17 13:17:14 volumio volumio[898]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8)
Jun 17 13:17:14 volumio volumio[898]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19)
Jun 17 13:17:14 volumio volumio[898]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10)
Jun 17 13:17:14 volumio volumio[898]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Jun 17 13:17:14 volumio volumio[898]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
Jun 17 13:17:14 volumio volumio[898]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1530:29)
Jun 17 13:17:14 volumio volumio[898]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1356:47)
Jun 17 13:17:14 volumio volumio[898]: at Socket.emit (events.js:315:20)
Jun 17 13:17:14 volumio volumio[898]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Jun 17 13:17:14 volumio volumio[898]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Jun 17 13:17:14 volumio volumio[898]: errno: -9,
Jun 17 13:17:14 volumio volumio[898]: syscall: 'close',
Jun 17 13:17:14 volumio volumio[898]: code: 'EBADF'
Jun 17 13:17:14 volumio volumio[898]: }
Jun 17 13:17:14 volumio volumio[898]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 17 13:17:16 volumio sudo[2250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-17 13:16
Jun 17 13:17:16 volumio sudo[2250]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST"
VOLUMIO_VERSION="3.569"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"