-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-01-17 02:16:32 CET. -- Jan 17 02:16:22 volumio volumio[1030]: info: MyVolumio login type: Token Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.845954, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jan 17 02:16:22 volumio systemd[1]: Starting Daily apt download activities... Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.850572, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.851176, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.851411, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 17 02:16:22 volumio nmbd[733]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.851674, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.851885, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 17 02:16:22 volumio nmbd[733]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.852123, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.852307, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 17 02:16:22 volumio nmbd[733]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.852527, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.852737, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 17 02:16:22 volumio nmbd[733]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.852925, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 17 02:16:22 volumio nmbd[733]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 17 02:16:22 volumio nmbd[733]: [2025/01/17 02:16:22.853086, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 17 02:16:22 volumio nmbd[733]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 17 02:16:23 volumio volumio-time-update[582]: volumio-time-update-util: Fetching time from Volumio... Jan 17 02:16:23 volumio volumio[1030]: SPOTIFY: SETTING SPOTIFY VOLUME 64 Jan 17 02:16:23 volumio volumio[1030]: info: Sending Spotify command with payload to local API: /player/volume Jan 17 02:16:23 volumio volumio[1030]: STREAMING PROXY: Starting server on port 3245 Jan 17 02:16:23 volumio volumio[1030]: Node JS runtime: 14 Jan 17 02:16:24 volumio volumio[1030]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 17 02:16:24 volumio systemd[1]: apt-daily.service: Succeeded. Jan 17 02:16:24 volumio systemd[1]: Started Daily apt download activities. Jan 17 02:16:24 volumio volumio-remote-updater[578]: No test mode Jan 17 02:16:24 volumio volumio-remote-updater[578]: No alpha test mode Jan 17 02:16:24 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 17 02:16:24 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jan 17 02:16:24 volumio volumio[1030]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 17 02:16:24 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 17 02:16:25 volumio volumio[1030]: info: MyVolumio token set successfully Jan 17 02:16:25 volumio volumio[1030]: info: MYVOLUMIO: Adding device Jan 17 02:16:25 volumio volumio[1030]: info: MYVOLUMIO: Evaluating Server Jan 17 02:16:26 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 17 02:16:26 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jan 17 02:16:26 volumio volumio[1030]: info: MyVolumio status changed Jan 17 02:16:26 volumio volumio[1030]: info: Streaming services startup Jan 17 02:16:26 volumio volumio[1030]: info: Starting Streaming Daemon Jan 17 02:16:26 volumio volumio[1030]: info: Removing browser output: myVolumio user plan is not superstar Jan 17 02:16:26 volumio volumio[1030]: info: Removing audio output: Jan 17 02:16:26 volumio volumio[1030]: info: Stoppping Tunnel 1 Jan 17 02:16:26 volumio sudo[1706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 17 02:16:26 volumio sudo[1706]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 02:16:26 volumio sudo[1709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jan 17 02:16:26 volumio sudo[1709]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 02:16:26 volumio sudo[1706]: pam_unix(sudo:session): session closed for user root Jan 17 02:16:26 volumio volumio[1030]: error: Cannot start Volumio Streaming Daemon Jan 17 02:16:26 volumio volumio[1030]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 17 02:16:26 volumio volumio[1030]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 17 02:16:26 volumio sudo[1709]: pam_unix(sudo:session): session closed for user root Jan 17 02:16:26 volumio volumio[1030]: info: Remote SSH Stopped Jan 17 02:16:26 volumio volumio[1030]: info: Setting Geolocation for MyVolumio to eu8 Jan 17 02:16:26 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 02:16:26 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 02:16:26 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 02:16:27 volumio volumio[1030]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jan 17 02:16:27 volumio volumio[1030]: info: Updating MyVolumio device info Jan 17 02:16:27 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 02:16:27 volumio volumio[1030]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 02:16:28 volumio volumio[1030]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: A device disappeared from network Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: Device volumio disappeared from network Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: A device disappeared from network Jan 17 02:16:31 volumio volumio[1030]: info: MYVOLUMIO: Adding device Jan 17 02:16:31 volumio volumio[1030]: info: MYVOLUMIO: Evaluating Server Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: adding d5f54646-0042-4be8-b14e-eb97de5b1da8 Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: Found device Volumio Jan 17 02:16:31 volumio volumio[1030]: info: CoreCommandRouter::volumioGetState Jan 17 02:16:31 volumio volumio[1030]: info: CorePlayQueue::getTrack 0 Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: this is already registered, d5f54646-0042-4be8-b14e-eb97de5b1da8 Jan 17 02:16:31 volumio volumio[1030]: info: Discovery: Found device Volumio Jan 17 02:16:31 volumio volumio[1030]: info: CoreCommandRouter::volumioGetState Jan 17 02:16:31 volumio volumio[1030]: info: CorePlayQueue::getTrack 0 Jan 17 02:16:31 volumio volumio-time-update[582]: volumio-time-update-util: Setting system time to: 2025-01-17 02:16:31 Jan 17 02:16:31 volumio sudo[1723]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-17 02:16:31 Jan 17 02:16:31 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 02:16:31 volumio dbus-daemon[596]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.17' (uid=0 pid=1725 comm="timedatectl set-time 2025-01-17 02:16:31 ") Jan 17 02:16:31 volumio systemd[1]: Starting Time & Date Service... Jan 17 02:16:31 volumio dbus-daemon[596]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 17 02:16:31 volumio systemd[1]: Started Time & Date Service. Jan 17 02:16:31 volumio systemd-timedated[1730]: Changed local time to Fri Jan 17 02:16:31 2025 Jan 17 02:16:31 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root Jan 17 02:16:31 volumio volumio-time-update[582]: volumio-time-update-util: System time updated successfully. Jan 17 02:16:31 volumio systemd[1]: Started Volumio Time Update Utility. Jan 17 02:16:31 volumio volumio[1030]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Jan 17 02:16:31 volumio volumio[1030]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 02:16:31 volumio systemd[1]: Reached target Multi-User System. Jan 17 02:16:31 volumio systemd[1]: Reached target Graphical Interface. Jan 17 02:16:31 volumio volumio[1030]: Error: Unable to resolve or reject the same promise twice Jan 17 02:16:31 volumio volumio[1030]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 17 02:16:31 volumio volumio[1030]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Jan 17 02:16:31 volumio volumio[1030]: at Socket.emit (events.js:327:22) Jan 17 02:16:31 volumio volumio[1030]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 17 02:16:31 volumio volumio[1030]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 17 02:16:31 volumio volumio[1030]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 02:16:31 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 17 02:16:31 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 17 02:16:31 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 17 02:16:31 volumio systemd[1]: Startup finished in 16.191s (kernel) + 1min 43.666s (userspace) = 1min 59.857s. Jan 17 02:16:32 volumio sudo[1747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 02:15 Jan 17 02:16:32 volumio sudo[1747]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"