-- Logs begin at Thu 2019-02-14 07:11:59 -03, end at Mon 2025-01-20 08:02:12 -03. -- Jan 20 08:02:06 musica-en-casa ntpd[775]: receive: Unexpected origin timestamp 0xeb368feb.c6ecec25 does not match aorg 0000000000.00000000 from server@168.96.251.197 xmt 0xeb38abae.e22a34a4 Jan 20 08:02:06 musica-en-casa ntpd[775]: receive: Unexpected origin timestamp 0xeb368feb.c6fe196e does not match aorg 0000000000.00000000 from server@168.96.251.195 xmt 0xeb38abae.e2e70a3a Jan 20 08:02:06 musica-en-casa volumio[1140]: info: Starting Streaming Service Transparent Proxy Jan 20 08:02:06 musica-en-casa systemd[1]: Starting Daily apt download activities... Jan 20 08:02:06 musica-en-casa volumio[1140]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 20 08:02:06 musica-en-casa volumio[1140]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 20 08:02:06 musica-en-casa volumio[1140]: info: Streaming services startup Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Starting Streaming Daemon Jan 20 08:02:07 musica-en-casa volumio[1140]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 20 08:02:07 musica-en-casa sudo[1636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 20 08:02:07 musica-en-casa sudo[1636]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 08:02:07 musica-en-casa volumio[1140]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Sending Spotify command with payload to local API: /player/volume Jan 20 08:02:07 musica-en-casa sudo[1636]: pam_unix(sudo:session): session closed for user root Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Getting Spotify volume Jan 20 08:02:07 musica-en-casa volumio[1140]: error: Cannot start Volumio Streaming Daemon Jan 20 08:02:07 musica-en-casa volumio[1140]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 20 08:02:07 musica-en-casa volumio[1140]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.455482, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 08:02:07 musica-en-casa nmbd[749]: Packet send failed to 192.168.0.255(138) ERRNO=Network is unreachable Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.456057, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 08:02:07 musica-en-casa nmbd[749]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.456278, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 20 08:02:07 musica-en-casa nmbd[749]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.456489, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 08:02:07 musica-en-casa nmbd[749]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.456653, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 20 08:02:07 musica-en-casa nmbd[749]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.456843, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 08:02:07 musica-en-casa nmbd[749]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.457005, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 20 08:02:07 musica-en-casa nmbd[749]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.457175, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 08:02:07 musica-en-casa nmbd[749]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.457357, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 20 08:02:07 musica-en-casa nmbd[749]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.457599, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 08:02:07 musica-en-casa nmbd[749]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Jan 20 08:02:07 musica-en-casa nmbd[749]: [2025/01/20 08:02:07.457828, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Jan 20 08:02:07 musica-en-casa nmbd[749]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Spotify volume: 100 Jan 20 08:02:07 musica-en-casa volumio[1140]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Discovery: A device disappeared from network Jan 20 08:02:07 musica-en-casa volumio[1140]: info: CoreCommandRouter::volumioGetState Jan 20 08:02:07 musica-en-casa volumio[1140]: info: CorePlayQueue::getTrack 0 Jan 20 08:02:07 musica-en-casa volumio[1140]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Discovery: adding 5c717219-3846-4ab4-882c-da840cadacb4 Jan 20 08:02:07 musica-en-casa volumio[1140]: info: Discovery: Found device Musica en Casa Jan 20 08:02:07 musica-en-casa volumio[1140]: info: CoreCommandRouter::volumioGetState Jan 20 08:02:07 musica-en-casa volumio[1140]: info: CorePlayQueue::getTrack 0 Jan 20 08:02:07 musica-en-casa volumio[1140]: error: MyVolumio Custom Token format not valid, refreshing it Jan 20 08:02:09 musica-en-casa volumio[1140]: info: MyVolumio login type: Token Jan 20 08:02:09 musica-en-casa systemd[1]: apt-daily.service: Succeeded. Jan 20 08:02:09 musica-en-casa systemd[1]: Started Daily apt download activities. Jan 20 08:02:09 musica-en-casa systemd[1]: Starting Daily apt upgrade and clean activities... Jan 20 08:02:09 musica-en-casa volumio[1140]: STREAMING PROXY: Starting server on port 3245 Jan 20 08:02:09 musica-en-casa volumio[1140]: Node JS runtime: 14 Jan 20 08:02:09 musica-en-casa volumio[1140]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 20 08:02:10 musica-en-casa volumio[1140]: info: MyVolumio token set successfully Jan 20 08:02:10 musica-en-casa volumio[1140]: info: MYVOLUMIO: Adding device Jan 20 08:02:10 musica-en-casa volumio[1140]: info: MYVOLUMIO: Evaluating Server Jan 20 08:02:10 musica-en-casa systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 20 08:02:10 musica-en-casa systemd[1]: Started Daily apt upgrade and clean activities. Jan 20 08:02:10 musica-en-casa volumio-time-update[620]: volumio-time-update-util: Fetching time from Volumio... Jan 20 08:02:10 musica-en-casa volumio[1140]: info: MyVolumio Plan changed: premium Jan 20 08:02:10 musica-en-casa volumio[1140]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 20 08:02:10 musica-en-casa volumio[1140]: info: Removing browser output: myVolumio user plan is not superstar Jan 20 08:02:10 musica-en-casa volumio[1140]: info: Removing audio output: Jan 20 08:02:10 musica-en-casa volumio[1140]: info: MYVOLUMIO: Adding device Jan 20 08:02:10 musica-en-casa volumio[1140]: info: MYVOLUMIO: Evaluating Server Jan 20 08:02:10 musica-en-casa wpa_supplicant[884]: wlan0: Failed to initiate sched scan Jan 20 08:02:10 musica-en-casa volumio[1140]: info: Remote config written successfully Jan 20 08:02:10 musica-en-casa volumio[1140]: info: Starting Tunnel 1 Jan 20 08:02:10 musica-en-casa volumio[1140]: info: Starting Tunnel Connection Checker Jan 20 08:02:11 musica-en-casa volumio-time-update[620]: volumio-time-update-util: Setting system time to: 2025-01-20 08:02:11 Jan 20 08:02:11 musica-en-casa sudo[1789]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-01-20 08:02:11 Jan 20 08:02:11 musica-en-casa sudo[1789]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 08:02:11 musica-en-casa dbus-daemon[608]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.15' (uid=0 pid=1792 comm="timedatectl set-time 2025-01-20 08:02:11 ") Jan 20 08:02:11 musica-en-casa volumio[1140]: info: MYVolumio Device enabled Jan 20 08:02:11 musica-en-casa volumio[1140]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 20 08:02:11 musica-en-casa volumio[1140]: info: MyVolumio status changed Jan 20 08:02:11 musica-en-casa volumio[1140]: info: Streaming services startup Jan 20 08:02:11 musica-en-casa volumio[1140]: info: Starting Streaming Daemon Jan 20 08:02:11 musica-en-casa systemd[1]: Starting Time & Date Service... Jan 20 08:02:11 musica-en-casa sudo[1798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 20 08:02:11 musica-en-casa sudo[1798]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 08:02:11 musica-en-casa volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 20 08:02:11 musica-en-casa volumio[1140]: error: [MyVolumio PluginManager] Cache data is invalid! Jan 20 08:02:11 musica-en-casa sudo[1798]: pam_unix(sudo:session): session closed for user root Jan 20 08:02:11 musica-en-casa volumio[1140]: error: Cannot start Volumio Streaming Daemon Jan 20 08:02:11 musica-en-casa volumio[1140]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 20 08:02:11 musica-en-casa volumio[1140]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 20 08:02:11 musica-en-casa dbus-daemon[608]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 20 08:02:11 musica-en-casa systemd[1]: Started Time & Date Service. Jan 20 08:02:11 musica-en-casa systemd-timedated[1796]: Changed local time to Mon Jan 20 08:02:11 2025 Jan 20 08:02:11 musica-en-casa systemd[1]: Started Volumio Time Update Utility. Jan 20 08:02:11 musica-en-casa volumio-time-update[620]: volumio-time-update-util: System time updated successfully. Jan 20 08:02:11 musica-en-casa sudo[1789]: pam_unix(sudo:session): session closed for user root Jan 20 08:02:11 musica-en-casa systemd[1]: Reached target Multi-User System. Jan 20 08:02:11 musica-en-casa systemd[1]: Reached target Graphical Interface. Jan 20 08:02:11 musica-en-casa volumio[1140]: error: Failed to ping endpoint as2.myvolumio.org : unknown error Jan 20 08:02:11 musica-en-casa volumio[1140]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 08:02:11 musica-en-casa volumio[1140]: Error: Unable to resolve or reject the same promise twice Jan 20 08:02:11 musica-en-casa volumio[1140]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 20 08:02:11 musica-en-casa volumio[1140]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Jan 20 08:02:11 musica-en-casa volumio[1140]: at Socket.emit (events.js:327:22) Jan 20 08:02:11 musica-en-casa volumio[1140]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 20 08:02:11 musica-en-casa volumio[1140]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 20 08:02:11 musica-en-casa volumio[1140]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 08:02:11 musica-en-casa systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 20 08:02:11 musica-en-casa systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 20 08:02:11 musica-en-casa systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 20 08:02:11 musica-en-casa systemd[1]: Startup finished in 16.024s (kernel) + 1min 59.416s (userspace) = 2min 15.440s. Jan 20 08:02:12 musica-en-casa sudo[1811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 08:01 Jan 20 08:02:12 musica-en-casa sudo[1811]: 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"