-- Logs begin at Mon 2024-11-25 22:29:32 CET, end at Mon 2025-03-10 19:46:12 CET. --
Mar 10 19:45:02 minidsp-shd kernel: scsi host0: uas_eh_device_reset_handler start
Mar 10 19:45:02 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#18 uas_zap_pending 0 uas-tag 1 inflight: CMD
Mar 10 19:45:02 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#18 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:45:02 minidsp-shd kernel: usb 4-1: reset high-speed USB device number 3 using xhci-hcd
Mar 10 19:45:02 minidsp-shd kernel: scsi host0: uas_eh_device_reset_handler success
Mar 10 19:45:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#19 data cmplt err -71 uas-tag 1 inflight: CMD
Mar 10 19:45:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#19 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:45:19 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Mar 10 19:45:19 minidsp-shd volumio[15100]: info: Loading i18n strings for locale de
Mar 10 19:45:19 minidsp-shd volumio[15100]: Updating browse sources language
Mar 10 19:45:19 minidsp-shd volumio[15100]: Cannot find translation for source Presets
Mar 10 19:45:19 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 10 19:45:19 minidsp-shd volumio[15100]: Cannot find translation for source Presets
Mar 10 19:45:19 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Mar 10 19:45:19 minidsp-shd volumio[15100]: info: Setting timezone to Europe/Vienna
Mar 10 19:45:19 minidsp-shd sudo[15775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Mar 10 19:45:19 minidsp-shd sudo[15775]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:19 minidsp-shd sudo[15775]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:20 minidsp-shd sudo[15778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Vienna /etc/localtime
Mar 10 19:45:20 minidsp-shd sudo[15778]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:20 minidsp-shd sudo[15778]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:20 minidsp-shd sudo[15781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Mar 10 19:45:20 minidsp-shd sudo[15781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:20 minidsp-shd sudo[15781]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:20 minidsp-shd sudo[15784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Vienna
Mar 10 19:45:20 minidsp-shd sudo[15784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:20 minidsp-shd dbus-daemon[447]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.62' (uid=0 pid=15785 comm="/usr/bin/timedatectl set-timezone Europe/Vienna ")
Mar 10 19:45:20 minidsp-shd systemd[1]: Starting Time & Date Service...
Mar 10 19:45:32 minidsp-shd kernel: scsi host0: uas_eh_device_reset_handler start
Mar 10 19:45:32 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#19 uas_zap_pending 0 uas-tag 1 inflight: CMD
Mar 10 19:45:32 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#19 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:45:32 minidsp-shd kernel: usb 4-1: reset high-speed USB device number 3 using xhci-hcd
Mar 10 19:45:33 minidsp-shd kernel: scsi host0: uas_eh_device_reset_handler success
Mar 10 19:45:33 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 data cmplt err -71 uas-tag 1 inflight: CMD
Mar 10 19:45:33 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:45:45 minidsp-shd dbus-daemon[447]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Mar 10 19:45:45 minidsp-shd sudo[15784]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:45 minidsp-shd volumio[15100]: Failed to set time zone: Connection timed out
Mar 10 19:45:45 minidsp-shd volumio[15100]: info: Could not set timezone, retrying
Mar 10 19:45:45 minidsp-shd volumio[15100]: info: Fetching Streaming Services browse cache
Mar 10 19:45:45 minidsp-shd volumio[15100]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 10 19:45:45 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Mar 10 19:45:45 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Mar 10 19:45:45 minidsp-shd sudo[15789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Mar 10 19:45:45 minidsp-shd sudo[15789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:45 minidsp-shd sudo[15789]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:45 minidsp-shd volumio[15100]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Mar 10 19:45:45 minidsp-shd volumio[15100]: wlan0 Interface doesn't support scanning.
Mar 10 19:45:45 minidsp-shd volumio[15100]: info: Cannot use regular scanning, forcing with ap-force
Mar 10 19:45:45 minidsp-shd sudo[15794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Mar 10 19:45:45 minidsp-shd sudo[15794]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:45 minidsp-shd sudo[15794]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:45 minidsp-shd volumio[15100]: command failed: No such device (-19)
Mar 10 19:45:46 minidsp-shd volumio[15100]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Mar 10 19:45:46 minidsp-shd volumio[15100]: command failed: No such device (-19)
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: System name has changed, restarting Shairport Sync
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 10 19:45:46 minidsp-shd volumio[15100]: xcb_connection_has_error() returned true
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 10 19:45:46 minidsp-shd volumio[15100]: xcb_connection_has_error() returned true
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: Updating MyVolumio device info
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 10 19:45:46 minidsp-shd volumio[15100]: info: Discovery: Restarting Advertising due to device name change
Mar 10 19:45:46 minidsp-shd sudo[15803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Mar 10 19:45:46 minidsp-shd sudo[15803]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:46 minidsp-shd sudo[15803]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:46 minidsp-shd systemd[1]: upmpdcli.service: Succeeded.
Mar 10 19:45:46 minidsp-shd sudo[15806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name minidsp-shd
Mar 10 19:45:46 minidsp-shd sudo[15806]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:46 minidsp-shd sudo[15806]: pam_unix(sudo:session): session closed for user root
Mar 10 19:45:46 minidsp-shd sudo[15809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Vienna
Mar 10 19:45:46 minidsp-shd sudo[15809]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 10 19:45:46 minidsp-shd dbus-daemon[447]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.63' (uid=0 pid=15812 comm="/usr/bin/timedatectl set-timezone Europe/Vienna ")
Mar 10 19:46:03 minidsp-shd kernel: scsi host0: uas_eh_device_reset_handler start
Mar 10 19:46:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 uas_zap_pending 0 uas-tag 1 inflight: CMD
Mar 10 19:46:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:46:03 minidsp-shd kernel: usb 4-1: reset high-speed USB device number 3 using xhci-hcd
Mar 10 19:46:03 minidsp-shd kernel: scsi host0: uas_eh_device_reset_handler success
Mar 10 19:46:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 UNKNOWN(0x2003) Result: hostbyte=0x08 driverbyte=0x08
Mar 10 19:46:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 Sense Key : 0x2 [current]
Mar 10 19:46:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 ASC=0x4 ASCQ=0x1
Mar 10 19:46:03 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#4 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:46:03 minidsp-shd kernel: blk_update_request: I/O error, dev sda, sector 65321 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Mar 10 19:46:03 minidsp-shd kernel: FAT-fs (sda1): FAT read failed (blocknr 65065)
Mar 10 19:46:05 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#21 data cmplt err -71 uas-tag 1 inflight: CMD
Mar 10 19:46:05 minidsp-shd kernel: sd 0:0:0:0: [sda] tag#21 CDB: opcode=0x28 28 00 00 00 ff 29 00 00 01 00
Mar 10 19:46:11 minidsp-shd dbus-daemon[447]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Mar 10 19:46:11 minidsp-shd sudo[15809]: pam_unix(sudo:session): session closed for user root
Mar 10 19:46:11 minidsp-shd volumio[15100]: Failed to set time zone: Connection timed out
Mar 10 19:46:11 minidsp-shd volumio[15100]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 10 19:46:11 minidsp-shd volumio[15100]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Europe/Vienna'
Mar 10 19:46:11 minidsp-shd volumio[15100]: Failed to set time zone: Connection timed out
Mar 10 19:46:11 minidsp-shd volumio[15100]: at checkExecSyncError (child_process.js:790:11)
Mar 10 19:46:11 minidsp-shd volumio[15100]: at execSync (child_process.js:863:15)
Mar 10 19:46:11 minidsp-shd volumio[15100]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1557:9)
Mar 10 19:46:11 minidsp-shd volumio[15100]: at listOnTimeout (internal/timers.js:557:17)
Mar 10 19:46:11 minidsp-shd volumio[15100]: at processTimers (internal/timers.js:500:7) {
Mar 10 19:46:11 minidsp-shd volumio[15100]: status: 1,
Mar 10 19:46:11 minidsp-shd volumio[15100]: signal: null,
Mar 10 19:46:11 minidsp-shd volumio[15100]: output: [ null, '', 'Failed to set time zone: Connection timed out\n' ],
Mar 10 19:46:11 minidsp-shd volumio[15100]: pid: 15807,
Mar 10 19:46:11 minidsp-shd volumio[15100]: stdout: '',
Mar 10 19:46:11 minidsp-shd volumio[15100]: stderr: 'Failed to set time zone: Connection timed out\n'
Mar 10 19:46:11 minidsp-shd volumio[15100]: }
Mar 10 19:46:11 minidsp-shd volumio[15100]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 10 19:46:12 minidsp-shd sudo[15862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 19:45
Mar 10 19:46:12 minidsp-shd sudo[15862]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="minidspshd"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:13:25 PM CET"
VOLUMIO_VERSION="3.608"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR="miniDSP"
VOLUMIO_MODEL="SHD"
VOLUMIO_VENDOR_MODEL="miniDSP SHD"
VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"