-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-06-08 16:18:32 CEST. --
Jun 08 16:17:09 volumio-under go-librespot[1418]: time="2025-06-08T16:17:09+02:00" level=error msg="did not receive last pong from dealer, 411s passed"
Jun 08 16:17:25 volumio-under volumiossh-tunnel[9536]: Connection to 185.14.187.123 port 2222 timed out
Jun 08 16:17:25 volumio-under autossh[9538]: ssh exited with error status 255; restarting ssh
Jun 08 16:17:25 volumio-under autossh[9538]: starting ssh (count 2)
Jun 08 16:17:25 volumio-under autossh[9538]: ssh child pid is 9773
Jun 08 16:17:25 volumio-under volumio[905]: BT PLUGIN MESSAGE: Duration is 186000
Jun 08 16:17:25 volumio-under volumio[905]: info: CoreCommandRouter::servicePushState
Jun 08 16:17:25 volumio-under volumio[905]: info: CoreStateMachine::pushState
Jun 08 16:17:25 volumio-under volumio[905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 16:17:25 volumio-under volumio[905]: info: CoreCommandRouter::volumioPushState
Jun 08 16:17:25 volumio-under volumio[905]: info: MRS: Pushing multiroomSync output update for this device
Jun 08 16:17:25 volumio-under volumio[905]: info: MRS: Pushing multiroomSync output
Jun 08 16:17:25 volumio-under volumio[905]: info: CoreCommandRouter::volumioGetState
Jun 08 16:17:25 volumio-under volumio[905]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74
Jun 08 16:17:26 volumio-under volumio[905]: info: CoreCommandRouter::servicePushState
Jun 08 16:17:26 volumio-under volumio[905]: info: CoreStateMachine::pushState
Jun 08 16:17:26 volumio-under volumio[905]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 08 16:17:26 volumio-under volumio[905]: info: CoreCommandRouter::volumioPushState
Jun 08 16:17:26 volumio-under volumio[905]: info: MRS: Pushing multiroomSync output update for this device
Jun 08 16:17:26 volumio-under volumio[905]: info: MRS: Pushing multiroomSync output
Jun 08 16:17:26 volumio-under volumio[905]: info: CoreCommandRouter::volumioGetState
Jun 08 16:17:26 volumio-under volumio[905]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74
Jun 08 16:17:28 volumio-under go-librespot[1418]: time="2025-06-08T16:17:28+02:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.1.133:59164->34.158.255.62:443: read: connection reset by peer"
Jun 08 16:17:33 volumio-under go-librespot[1418]: time="2025-06-08T16:17:33+02:00" level=debug msg="connected to ap-gew1.spotify.com:80"
Jun 08 16:17:33 volumio-under volumiossh-tunnel[9536]: Warning: Permanently added '[eu2.myvolumio.org]:2222,[185.14.187.123]:2222' (RSA) to the list of known hosts.
Jun 08 16:17:33 volumio-under go-librespot[1418]: time="2025-06-08T16:17:33+02:00" level=debug msg="completed keyexchange"
Jun 08 16:17:33 volumio-under go-librespot[1418]: time="2025-06-08T16:17:33+02:00" level=debug msg="completed challenge"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=info msg="authenticated AP as stratocaster74"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=debug msg="re-established accesspoint connection"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=trace msg="received accesspoint ping"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Jun 08 16:17:35 volumio-under go-librespot[1418]: time="2025-06-08T16:17:35+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Jun 08 16:17:39 volumio-under go-librespot[1418]: time="2025-06-08T16:17:39+02:00" level=error msg="did not receive last pong from dealer, 441s passed"
Jun 08 16:18:09 volumio-under go-librespot[1418]: time="2025-06-08T16:18:09+02:00" level=error msg="did not receive last pong ack from accesspoint, 182s passed"
Jun 08 16:18:09 volumio-under go-librespot[1418]: time="2025-06-08T16:18:09+02:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.1.133:39804->104.199.65.9:80: use of closed network connection"
Jun 08 16:18:09 volumio-under go-librespot[1418]: time="2025-06-08T16:18:09+02:00" level=error msg="did not receive last pong from dealer, 471s passed"
Jun 08 16:18:10 volumio-under ntpd[688]: 83.150.25.25 local addr 192.168.1.133 ->
Jun 08 16:18:11 volumio-under ntpd[688]: Soliciting pool server 109.233.182.115
Jun 08 16:18:19 volumio-under go-librespot[1418]: time="2025-06-08T16:18:19+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Jun 08 16:18:29 volumio-under volumio[905]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 08 16:18:29 volumio-under volumio[905]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net
Jun 08 16:18:29 volumio-under volumio[905]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) {
Jun 08 16:18:29 volumio-under volumio[905]: errno: -3007,
Jun 08 16:18:29 volumio-under volumio[905]: code: 'ENOTFOUND',
Jun 08 16:18:29 volumio-under volumio[905]: syscall: 'getaddrinfo',
Jun 08 16:18:29 volumio-under volumio[905]: hostname: 'lastfm.freetls.fastly.net'
Jun 08 16:18:29 volumio-under volumio[905]: }
Jun 08 16:18:29 volumio-under volumio[905]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 08 16:18:32 volumio-under sudo[9966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-08 16:17
Jun 08 16:18:32 volumio-under sudo[9966]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"