-- Logs begin at Sun 2022-09-25 14:08:07 UTC, end at Thu 2024-10-31 17:19:19 UTC. -- Oct 31 17:18:00 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:01 volumio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Oct 31 17:18:01 volumio dhcpcd[8677]: sending commands to master dhcpcd process Oct 31 17:18:01 volumio ifplugd(eth0)[666]: client: sending commands to master dhcpcd process Oct 31 17:18:01 volumio dhcpcd[960]: control command: /sbin/dhcpcd -k eth0 Oct 31 17:18:01 volumio dhcpcd[960]: eth0: removing interface Oct 31 17:18:01 volumio ifplugd(eth0)[666]: Program executed successfully. Oct 31 17:18:04 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:05 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 17:18:05 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 17:18:05 volumio volumio[984]: info: Discovery: Getting this device information Oct 31 17:18:05 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Oct 31 17:18:05 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 17:18:06 volumio kernel: setLedConfiguration: #### before setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:18:06 volumio kernel: setLedConfiguration: #### after setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:18:06 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 31 17:18:06 volumio ifplugd(eth0)[666]: Link beat detected. Oct 31 17:18:06 volumio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 31 17:18:06 volumio dhcpcd[8724]: sending commands to master dhcpcd process Oct 31 17:18:06 volumio ifplugd(eth0)[666]: client: sending commands to master dhcpcd process Oct 31 17:18:06 volumio dhcpcd[960]: control command: /sbin/dhcpcd eth0 Oct 31 17:18:06 volumio dhcpcd[960]: eth0: carrier acquired Oct 31 17:18:06 volumio dhcpcd[960]: eth0: IAID 3f:cd:ac:93 Oct 31 17:18:07 volumio ifplugd(eth0)[666]: Program executed successfully. Oct 31 17:18:07 volumio dhcpcd[960]: eth0: soliciting an IPv6 router Oct 31 17:18:07 volumio dhcpcd[960]: eth0: rebinding lease of 192.168.1.185 Oct 31 17:18:08 volumio dhcpcd[960]: eth0: carrier lost Oct 31 17:18:08 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Down Oct 31 17:18:08 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:09 volumio ifplugd(eth0)[666]: Link beat lost. Oct 31 17:18:12 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:13 volumio volumio[2563]: [Vollibrespot] : couldn't parse packet from 192.168.1.187:5353: type 47 is invalid Oct 31 17:18:13 volumio volumio[2563]: [Vollibrespot] : couldn't parse packet from 192.168.1.187:5353: type 47 is invalid Oct 31 17:18:14 volumio kernel: setLedConfiguration: #### before setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:18:14 volumio kernel: setLedConfiguration: #### after setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:18:14 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 31 17:18:14 volumio dhcpcd[960]: eth0: carrier acquired Oct 31 17:18:14 volumio dhcpcd[960]: eth0: IAID 3f:cd:ac:93 Oct 31 17:18:14 volumio dhcpcd[960]: eth0: soliciting an IPv6 router Oct 31 17:18:15 volumio dhcpcd[960]: eth0: rebinding lease of 192.168.1.185 Oct 31 17:18:15 volumio dhcpcd[960]: eth0: probing address 192.168.1.185/24 Oct 31 17:18:15 volumio ifplugd(eth0)[666]: Link beat detected. Oct 31 17:18:16 volumio dhcpcd[960]: eth0: carrier lost Oct 31 17:18:16 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Down Oct 31 17:18:16 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:17 volumio ifplugd(eth0)[666]: Link beat lost. Oct 31 17:18:20 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:24 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:26 volumio volumio[984]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Oct 31 17:18:27 volumio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Oct 31 17:18:27 volumio ifplugd(eth0)[666]: client: sending commands to master dhcpcd process Oct 31 17:18:27 volumio dhcpcd[8821]: sending commands to master dhcpcd process Oct 31 17:18:27 volumio dhcpcd[960]: control command: /sbin/dhcpcd -k eth0 Oct 31 17:18:27 volumio dhcpcd[960]: eth0: removing interface Oct 31 17:18:27 volumio ifplugd(eth0)[666]: Program executed successfully. Oct 31 17:18:28 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:32 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:35 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 17:18:35 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 17:18:35 volumio volumio[984]: info: Discovery: Getting this device information Oct 31 17:18:35 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Oct 31 17:18:35 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 17:18:36 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:40 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:42 volumio volumio[2563]: [Vollibrespot] : couldn't parse packet from 192.168.1.187:5353: type 47 is invalid Oct 31 17:18:42 volumio volumio[2563]: [Vollibrespot] : couldn't parse packet from 192.168.1.187:5353: type 47 is invalid Oct 31 17:18:44 volumio kernel: setLedConfiguration: #### before setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:18:44 volumio kernel: setLedConfiguration: #### after setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:18:44 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 31 17:18:44 volumio ifplugd(eth0)[666]: Link beat detected. Oct 31 17:18:44 volumio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 31 17:18:44 volumio ifplugd(eth0)[666]: client: sending commands to master dhcpcd process Oct 31 17:18:44 volumio dhcpcd[8869]: sending commands to master dhcpcd process Oct 31 17:18:44 volumio dhcpcd[960]: control command: /sbin/dhcpcd eth0 Oct 31 17:18:44 volumio dhcpcd[960]: eth0: carrier acquired Oct 31 17:18:44 volumio dhcpcd[960]: eth0: IAID 3f:cd:ac:93 Oct 31 17:18:44 volumio ifplugd(eth0)[666]: Program executed successfully. Oct 31 17:18:44 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:45 volumio dhcpcd[960]: eth0: soliciting an IPv6 router Oct 31 17:18:45 volumio dhcpcd[960]: eth0: rebinding lease of 192.168.1.185 Oct 31 17:18:46 volumio dhcpcd[960]: eth0: carrier lost Oct 31 17:18:46 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Down Oct 31 17:18:46 volumio ifplugd(eth0)[666]: Link beat lost. Oct 31 17:18:48 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:52 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:56 volumio volumio[984]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Oct 31 17:18:56 volumio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Oct 31 17:18:56 volumio dhcpcd[8934]: sending commands to master dhcpcd process Oct 31 17:18:56 volumio ifplugd(eth0)[666]: client: sending commands to master dhcpcd process Oct 31 17:18:56 volumio dhcpcd[960]: control command: /sbin/dhcpcd -k eth0 Oct 31 17:18:56 volumio dhcpcd[960]: eth0: removing interface Oct 31 17:18:56 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:18:56 volumio ifplugd(eth0)[666]: Program executed successfully. Oct 31 17:19:00 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:19:04 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:19:05 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 17:19:05 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 17:19:05 volumio volumio[984]: info: Discovery: Getting this device information Oct 31 17:19:05 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Oct 31 17:19:05 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 17:19:08 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:19:11 volumio volumio[984]: info: Disabling MyMusic plugin upnp_browser Oct 31 17:19:11 volumio volumio[984]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Oct 31 17:19:11 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourceBandcamp Discover Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourceJellyfin Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourceMixcloud Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourceSoundCloud Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for source80s80s Radio Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourcePersonal Radio Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourceRadio Paradise Oct 31 17:19:11 volumio volumio[984]: Cannot find translation for sourceVolusonic Oct 31 17:19:11 volumio volumio[984]: info: Disabling plugin upnp_browser Oct 31 17:19:11 volumio volumio[984]: info: Done. Oct 31 17:19:11 volumio volumio[2563]: [Vollibrespot] : couldn't parse packet from 192.168.1.187:5353: type 47 is invalid Oct 31 17:19:11 volumio volumio[2563]: [Vollibrespot] : couldn't parse packet from 192.168.1.187:5353: type 47 is invalid Oct 31 17:19:12 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:19:13 volumio kernel: setLedConfiguration: #### before setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:19:13 volumio kernel: setLedConfiguration: #### after setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:19:13 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 31 17:19:13 volumio ifplugd(eth0)[666]: Link beat detected. Oct 31 17:19:13 volumio ifplugd(eth0)[666]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 31 17:19:13 volumio ifplugd(eth0)[666]: client: sending commands to master dhcpcd process Oct 31 17:19:13 volumio dhcpcd[8983]: sending commands to master dhcpcd process Oct 31 17:19:13 volumio dhcpcd[960]: control command: /sbin/dhcpcd eth0 Oct 31 17:19:13 volumio dhcpcd[960]: eth0: carrier acquired Oct 31 17:19:13 volumio dhcpcd[960]: eth0: IAID 3f:cd:ac:93 Oct 31 17:19:13 volumio dhcpcd[960]: eth0: rebinding lease of 192.168.1.185 Oct 31 17:19:13 volumio ifplugd(eth0)[666]: Program executed successfully. Oct 31 17:19:14 volumio dhcpcd[960]: eth0: soliciting an IPv6 router Oct 31 17:19:14 volumio volumio[984]: info: Enabling MyMusic plugin upnp_browser Oct 31 17:19:14 volumio volumio[984]: info: Enabling plugin upnp_browser Oct 31 17:19:14 volumio volumio[984]: info: Loading plugin "upnp_browser"... Oct 31 17:19:14 volumio volumio[984]: info: PLUGIN START: upnp_browser Oct 31 17:19:14 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 31 17:19:14 volumio volumio[984]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 31 17:19:14 volumio volumio[984]: info: [1730395154471] CoreMusicLibrary::Adding element Media Servers Oct 31 17:19:14 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceBandcamp Discover Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceJellyfin Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceMixcloud Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceSoundCloud Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for source80s80s Radio Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourcePersonal Radio Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceRadio Paradise Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceVolusonic Oct 31 17:19:14 volumio volumio[984]: Cannot find translation for sourceMedia Servers Oct 31 17:19:14 volumio volumio[984]: info: Done. Oct 31 17:19:15 volumio dhcpcd[960]: eth0: carrier lost Oct 31 17:19:15 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Down Oct 31 17:19:15 volumio ifplugd(eth0)[666]: Link beat lost. Oct 31 17:19:16 volumio kernel: setLedConfiguration: #### before setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:19:16 volumio kernel: setLedConfiguration: #### after setting led, Reg26 = 0x91 , Reg28 = 0x9040 Oct 31 17:19:16 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 31 17:19:16 volumio dhcpcd[960]: eth0: carrier acquired Oct 31 17:19:16 volumio dhcpcd[960]: eth0: IAID 3f:cd:ac:93 Oct 31 17:19:16 volumio dhcpcd[960]: eth0: rebinding lease of 192.168.1.185 Oct 31 17:19:16 volumio ifplugd(eth0)[666]: Link beat detected. Oct 31 17:19:16 volumio dhcpcd[960]: eth0: soliciting an IPv6 router Oct 31 17:19:16 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 31 17:19:17 volumio volumio[984]: info: Disabling MyMusic plugin upnp Oct 31 17:19:17 volumio sudo[9044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 31 17:19:17 volumio sudo[9044]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 17:19:17 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 31 17:19:17 volumio volumio[984]: error: Upnp client error: Error: This socket has been ended by the other party Oct 31 17:19:17 volumio volumio[984]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 17:19:17 volumio volumio[984]: BT PLUGIN MESSAGE: Playing: false Oct 31 17:19:17 volumio volumio[984]: BT PLUGIN MESSAGE: VOLATILE: undefined Oct 31 17:19:17 volumio volumio[984]: BT PLUGIN MESSAGE: STATE:undefined Oct 31 17:19:18 volumio dhcpcd[960]: eth0: carrier lost Oct 31 17:19:18 volumio kernel: rk_gmac-dwmac ff290000.ethernet eth0: Link is Down Oct 31 17:19:18 volumio ifplugd(eth0)[666]: Link beat lost. Oct 31 17:19:19 volumio volumio[984]: info: Enabling MyMusic plugin upnp Oct 31 17:19:19 volumio volumio[984]: info: Enabling plugin upnp Oct 31 17:19:19 volumio volumio[984]: info: Loading plugin "upnp"... Oct 31 17:19:19 volumio volumio[984]: info: [1730395159096] Starting Upmpd Daemon Oct 31 17:19:19 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 31 17:19:19 volumio volumio[984]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 17:19:19 volumio volumio[984]: Error: listen EADDRINUSE: address already in use :::6599 Oct 31 17:19:19 volumio volumio[984]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Oct 31 17:19:19 volumio volumio[984]: at listenInCluster (net.js:1379:12) Oct 31 17:19:19 volumio volumio[984]: at Server.listen (net.js:1465:7) Oct 31 17:19:19 volumio volumio[984]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 31 17:19:19 volumio volumio[984]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 31 17:19:19 volumio volumio[984]: at Promise._successFn (/volumio/app/pluginmanager.js:1837:19) Oct 31 17:19:19 volumio volumio[984]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 31 17:19:19 volumio volumio[984]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Oct 31 17:19:19 volumio volumio[984]: code: 'EADDRINUSE', Oct 31 17:19:19 volumio volumio[984]: errno: -98, Oct 31 17:19:19 volumio volumio[984]: syscall: 'listen', Oct 31 17:19:19 volumio volumio[984]: address: '::', Oct 31 17:19:19 volumio volumio[984]: port: 6599 Oct 31 17:19:19 volumio volumio[984]: } Oct 31 17:19:19 volumio volumio[984]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 17:19:19 volumio sudo[9090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-31 17:18 Oct 31 17:19:19 volumio sudo[9090]: 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="682e0b17433cee9f9da31457f545345105e06e63" VOLUMIO_FE_VERSION="fba46add594d630e1b506bc42f1beddaad53fb64" VOLUMIO_FE3_VERSION="c23fef6dba8e02db978bd39bd8d26872e60ada6e" VOLUMIO_BE_VERSION="f7885966dee9f148ddf4f5050103a7d6734e1a10" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 20 Dec 2021 05:15:13 PM CET" VOLUMIO_VERSION="3.179" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="eb25511d05ac417632afe20391ac0304"