-- Logs begin at Fri 2023-10-20 18:10:08 UTC, end at Wed 2024-08-28 07:23:54 UTC. -- Aug 28 07:22:04 volumio systemd[1]: Starting Daily apt download activities... Aug 28 07:22:04 volumio ntpd[661]: receive: Unexpected origin timestamp 0xe8dd4152.4ec1a088 does not match aorg 0000000000.00000000 from server@117.80.112.205 xmt 0xea794e9c.adf8983a Aug 28 07:22:04 volumio ntpd[661]: receive: Unexpected origin timestamp 0xe8dd4152.4ec84d35 does not match aorg 0000000000.00000000 from server@211.68.71.26 xmt 0xea794e9c.b09bfcfa Aug 28 07:22:04 volumio volumio[868]: info: CorePlayQueue::getTrack 3 Aug 28 07:22:04 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:04 volumio volumio[868]: info: Prefetching next song Aug 28 07:22:04 volumio volumio[868]: info: DOING PREFETCH IN MPD Aug 28 07:22:04 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand add "USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/02 火炬行動.wav" Aug 28 07:22:04 volumio volumio[868]: info: CoreStateMachine::startPlaybackTimer Aug 28 07:22:04 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:04 volumio volumio[868]: info: sendMpdCommand add "USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/02 火炬行動.wav" took 1 milliseconds Aug 28 07:22:04 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 28 07:22:04 volumio volumio[868]: info: Aug 28 07:22:04 volumio volumio[868]: ---------------------------- MPD announces system playlist update Aug 28 07:22:04 volumio volumio[868]: info: Ignoring MPD Status Update Aug 28 07:22:04 volumio volumio[868]: info: Aug 28 07:22:04 volumio volumio[868]: ---------------------------- MPD announces state update: options Aug 28 07:22:04 volumio volumio[868]: info: sendMpdCommand consume 1 took 2 milliseconds Aug 28 07:22:04 volumio volumio[868]: info: ControllerMpd::getState Aug 28 07:22:04 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand status Aug 28 07:22:04 volumio volumio[868]: info: ------------------------------ 4ms Aug 28 07:22:04 volumio volumio[868]: info: sendMpdCommand status took 2 milliseconds Aug 28 07:22:04 volumio volumio[868]: verbose: ControllerMpd::parseState Aug 28 07:22:04 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 07:22:04 volumio volumio[868]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 28 07:22:04 volumio volumio[868]: verbose: ControllerMpd::parseTrackInfo Aug 28 07:22:04 volumio volumio[868]: info: ControllerMpd::pushState Aug 28 07:22:04 volumio volumio[868]: info: CoreCommandRouter::servicePushState Aug 28 07:22:04 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:04 volumio volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9097,"duration":166,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"010 Heartbeat.wav","artist":null,"album":null,"uri":"USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/010 Heartbeat.wav","trackType":"wav"} Aug 28 07:22:04 volumio volumio[868]: verbose: CURRENT POSITION 4 Aug 28 07:22:04 volumio volumio[868]: info: CoreStateMachine::syncState stateService play Aug 28 07:22:04 volumio volumio[868]: info: CoreStateMachine::syncState currentStatus play Aug 28 07:22:04 volumio volumio[868]: info: Received an update from plugin. extracting info from payload Aug 28 07:22:04 volumio volumio[868]: info: CoreStateMachine::pushState Aug 28 07:22:04 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:04 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 07:22:04 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 28 07:22:04 volumio volumio[868]: info: CoreStateMachine::pushState Aug 28 07:22:04 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:04 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 28 07:22:04 volumio volumio[868]: info: ------------------------------ 18ms Aug 28 07:22:05 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:05 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:06 volumio systemd[1]: apt-daily.service: Succeeded. Aug 28 07:22:06 volumio systemd[1]: Started Daily apt download activities. Aug 28 07:22:06 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Aug 28 07:22:07 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:07 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:07 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Aug 28 07:22:07 volumio systemd[1]: Started Daily apt upgrade and clean activities. Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123025, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 07:22:08 volumio nmbd[642]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123358, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 07:22:08 volumio nmbd[642]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123471, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 28 07:22:08 volumio nmbd[642]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123607, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 07:22:08 volumio nmbd[642]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123711, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 28 07:22:08 volumio nmbd[642]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123839, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 07:22:08 volumio nmbd[642]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.123926, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 28 07:22:08 volumio nmbd[642]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.124025, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 07:22:08 volumio nmbd[642]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.124107, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 28 07:22:08 volumio nmbd[642]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.124185, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 28 07:22:08 volumio nmbd[642]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 28 07:22:08 volumio nmbd[642]: [2024/08/28 07:22:08.124299, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 28 07:22:08 volumio nmbd[642]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 28 07:22:08 volumio volumio[868]: info: Aug 28 07:22:08 volumio volumio[868]: ---------------------------- Client requests Volumio next Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::volumioNext Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::next Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::stop Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::stPlaybackTimer Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::updateTrackBlock Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrackBlock Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::pushState Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::serviceStop Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 4 Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::serviceStop Aug 28 07:22:08 volumio volumio[868]: info: ControllerMpd::stop Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand stop took 120 milliseconds Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::play index undefined Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::startPlaybackTimer Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::clearAddPlayTracks USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/03 不覊戀人(認真版本).wav Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand stop Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::updateTrackBlock Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrackBlock Aug 28 07:22:08 volumio volumio[868]: info: Aug 28 07:22:08 volumio volumio[868]: ---------------------------- MPD announces state update: player Aug 28 07:22:08 volumio volumio[868]: info: ControllerMpd::getState Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand status Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand stop took 2 milliseconds Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand clear Aug 28 07:22:08 volumio volumio[868]: info: Aug 28 07:22:08 volumio volumio[868]: ---------------------------- MPD announces system playlist update Aug 28 07:22:08 volumio volumio[868]: info: Ignoring MPD Status Update Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand status took 2 milliseconds Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand clear took 1 milliseconds Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::parseState Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand add "USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/03 不覊戀人(認真版本).wav" Aug 28 07:22:08 volumio volumio[868]: error: updateQueue error: null Aug 28 07:22:08 volumio volumio[868]: info: Aug 28 07:22:08 volumio volumio[868]: ---------------------------- MPD announces system playlist update Aug 28 07:22:08 volumio volumio[868]: info: Ignoring MPD Status Update Aug 28 07:22:08 volumio volumio[868]: info: ------------------------------ 3ms Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand add "USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/03 不覊戀人(認真版本).wav" took 3 milliseconds Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::parseTrackInfo Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand play Aug 28 07:22:08 volumio volumio[868]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 28 07:22:08 volumio volumio[868]: info: ------------------------------ 9ms Aug 28 07:22:08 volumio volumio[868]: info: ------------------------------ 4ms Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand play took 2 milliseconds Aug 28 07:22:08 volumio volumio[868]: info: Aug 28 07:22:08 volumio volumio[868]: ---------------------------- MPD announces state update: player Aug 28 07:22:08 volumio volumio[868]: info: ControllerMpd::getState Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand status Aug 28 07:22:08 volumio volumio[868]: info: Aug 28 07:22:08 volumio volumio[868]: ---------------------------- MPD announces state update: player Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand status took 9 milliseconds Aug 28 07:22:08 volumio volumio[868]: info: ControllerMpd::getState Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand status Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::parseState Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand status took 3 milliseconds Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::parseState Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::parseTrackInfo Aug 28 07:22:08 volumio volumio[868]: info: ControllerMpd::pushState Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::servicePushState Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:08 volumio volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 不覊戀人(認真版本).wav","artist":null,"album":null,"uri":"USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/03 不覊戀人(認真版本).wav","trackType":"wav"} Aug 28 07:22:08 volumio volumio[868]: verbose: CURRENT POSITION 5 Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::syncState stateService play Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::syncState currentStatus stop Aug 28 07:22:08 volumio volumio[868]: info: ------------------------------ 18ms Aug 28 07:22:08 volumio volumio[868]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 28 07:22:08 volumio volumio[868]: verbose: ControllerMpd::parseTrackInfo Aug 28 07:22:08 volumio volumio[868]: info: ControllerMpd::pushState Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::servicePushState Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:08 volumio volumio[868]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"duration":291,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03 不覊戀人(認真版本).wav","artist":null,"album":null,"uri":"USB/5292E0A192E08B35/1音乐/2劲歌火凤凰汽车音响/03 不覊戀人(認真版本).wav","trackType":"wav"} Aug 28 07:22:08 volumio volumio[868]: verbose: CURRENT POSITION 5 Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::syncState stateService play Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::syncState currentStatus play Aug 28 07:22:08 volumio volumio[868]: info: Received an update from plugin. extracting info from payload Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::pushState Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 28 07:22:08 volumio volumio[868]: info: CoreStateMachine::pushState Aug 28 07:22:08 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:08 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 28 07:22:08 volumio volumio[868]: info: ------------------------------ 25ms Aug 28 07:22:09 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:09 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:11 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:11 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:13 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:13 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 28 07:22:14 volumio volumio[868]: info: Adding plugin bluetooth to MyMusic Plugins Aug 28 07:22:14 volumio volumio[868]: info: Adding plugin multiroom to MyMusic Plugins Aug 28 07:22:14 volumio volumio[868]: info: Adding plugin metavolumio to MyMusic Plugins Aug 28 07:22:14 volumio volumio[868]: info: Adding plugin cd_controller to MyMusic Plugins Aug 28 07:22:14 volumio volumio[868]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 28 07:22:14 volumio volumio[868]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 28 07:22:14 volumio volumio[868]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 28 07:22:14 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 07:22:14 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 07:22:14 volumio volumio[868]: info: Starting MyVolumio Remote Streaming Endpoints Aug 28 07:22:15 volumio volumio[868]: info: MyVolumio login type: Token Aug 28 07:22:15 volumio volumio[868]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 28 07:22:15 volumio volumio[868]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 28 07:22:15 volumio volumio[868]: info: Starting Streaming Service Transparent Proxy Aug 28 07:22:15 volumio volumio[868]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 28 07:22:15 volumio volumio[868]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 28 07:22:15 volumio volumio[868]: info: Streaming services startup Aug 28 07:22:15 volumio volumio[868]: info: Starting Streaming Daemon Aug 28 07:22:16 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 28 07:22:16 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 28 07:22:16 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root Aug 28 07:22:16 volumio volumio[868]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 28 07:22:16 volumio volumio[868]: error: Cannot start Volumio Streaming Daemon Aug 28 07:22:16 volumio volumio[868]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 28 07:22:16 volumio volumio[868]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 28 07:22:16 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:16 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:16 volumio volumio[868]: STREAMING PROXY: Starting server on port 3245 Aug 28 07:22:16 volumio volumio[868]: Node JS runtime: 14 Aug 28 07:22:17 volumio volumio[868]: info: Discovery: A device disappeared from network Aug 28 07:22:17 volumio volumio[868]: info: Discovery: Device volumio disappeared from network Aug 28 07:22:17 volumio volumio[868]: info: Discovery: adding 705538e4-effc-4b8e-96e1-086e8b8d56f7 Aug 28 07:22:17 volumio volumio[868]: info: Discovery: Found device Volumio Aug 28 07:22:17 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:17 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:18 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:18 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:20 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:20 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:22 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:22 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:24 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:24 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:26 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:26 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:28 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:28 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:29 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 28 07:22:29 volumio volumio[868]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Aug 28 07:22:30 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:30 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:30 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:30 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:31 volumio volumio[868]: verbose: New Socket.io Connection to 192.168.100.199 from 192.168.100.184 UA: Mozilla/5.0 (Linux; Android 12; HarmonyOS; MNA-AL00; HMSCore 6.14.0.302) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/99.0.4844.88 HuaweiBrowser/15.0.2.310 Mobile Safari/537.36 Total Clients: 5 Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::volumioGetVisibleSources Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:31 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::volumioGetQueue Aug 28 07:22:31 volumio volumio[868]: info: CoreStateMachine::getQueue Aug 28 07:22:31 volumio volumio[868]: info: CorePlayQueue::getQueue Aug 28 07:22:31 volumio volumio[868]: info: Listing playlists Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 28 07:22:31 volumio volumio[868]: info: Received Get System Info Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 28 07:22:31 volumio volumio[868]: info: Discovery: Getting this device information Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:31 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 28 07:22:31 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:31 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:32 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:32 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:32 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 28 07:22:34 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:34 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:36 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:36 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:38 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:38 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:40 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:40 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:42 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:42 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:44 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:44 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:46 volumio volumio[868]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Aug 28 07:22:46 volumio volumio[868]: info: Retrying Login Due to Network Error Aug 28 07:22:46 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:46 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:48 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:48 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:51 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:51 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:53 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:53 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:55 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:55 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:56 volumio volumio[868]: info: MyVolumio login type: Token Aug 28 07:22:57 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:57 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:22:59 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:22:59 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:01 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:01 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:03 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:03 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:05 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:05 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:07 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:07 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:09 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:09 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:11 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:11 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:13 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:13 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:15 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:15 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:17 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:17 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:19 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:19 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:21 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:21 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:23 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:23 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:25 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:25 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:26 volumio volumio[868]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Aug 28 07:23:26 volumio volumio[868]: info: Retrying Login Due to Network Error Aug 28 07:23:27 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:28 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:30 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:30 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:32 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:32 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:34 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:34 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:36 volumio volumio[868]: info: MyVolumio login type: Token Aug 28 07:23:36 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:36 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:38 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:38 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:40 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:40 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:42 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:42 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:44 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:44 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:46 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:46 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:48 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:48 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:50 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:50 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:52 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 28 07:23:52 volumio volumio[868]: info: CorePlayQueue::getTrack 5 Aug 28 07:23:54 volumio volumio[868]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 07:23:54 volumio volumio[868]: Error: connect ETIMEDOUT 128.242.240.218:443 Aug 28 07:23:54 volumio volumio[868]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 28 07:23:54 volumio volumio[868]: errno: -110, Aug 28 07:23:54 volumio volumio[868]: code: 'ETIMEDOUT', Aug 28 07:23:54 volumio volumio[868]: syscall: 'connect', Aug 28 07:23:54 volumio volumio[868]: address: '128.242.240.218', Aug 28 07:23:54 volumio volumio[868]: port: 443 Aug 28 07:23:54 volumio volumio[868]: } Aug 28 07:23:54 volumio volumio[868]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 07:23:54 volumio sudo[2454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-28 07:22 Aug 28 07:23:54 volumio sudo[2454]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"