-- Logs begin at Fri 2024-10-04 18:53:27 +07, end at Fri 2024-10-04 18:55:55 +07. -- Oct 04 18:54:00 volumio sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Oct 04 18:54:00 volumio sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:54:00 volumio volumio[867]: info: camilladsp spawned new process with pid 1627, instance 1, run: true Oct 04 18:54:00 volumio volumio[867]: warn: [squeezelite_mc] No supported ALSA formats found for card 5 Oct 04 18:54:00 volumio volumio[867]: warn: [squeezelite_mc] No ALSA formats returned for card 5 Oct 04 18:54:00 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 04 18:54:00 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 04 18:54:00 volumio sudo[1626]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:00 volumio volumio[867]: info: camilladsp spawned new process with pid 1637, instance 1, run: true Oct 04 18:54:00 volumio volumio[867]: info: camilladsp spawned new process with pid 1646, instance 1, run: true Oct 04 18:54:00 volumio volumio[867]: info: camilladsp spawned new process with pid 1653, instance 1, run: true Oct 04 18:54:00 volumio volumio[867]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 04 18:54:01 volumio sudo[1661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 04 18:54:01 volumio sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:54:01 volumio volumio[867]: info: camilladsp spawned new process with pid 1662, instance 1, run: true Oct 04 18:54:01 volumio sudo[1661]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:01 volumio volumio[867]: info: camilladsp spawned new process with pid 1670, instance 1, run: true Oct 04 18:54:01 volumio volumio[867]: info: camilladsp spawned new process with pid 1677, instance 1, run: true Oct 04 18:54:01 volumio volumio[867]: info: camilladsp spawned new process with pid 1684, instance 1, run: true Oct 04 18:54:01 volumio volumio[867]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 04 18:54:01 volumio sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 04 18:54:01 volumio volumio[867]: info: camilladsp spawned new process with pid 1693, instance 1, run: true Oct 04 18:54:01 volumio sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:54:02 volumio sudo[1692]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:02 volumio volumio[867]: info: camilladsp spawned new process with pid 1701, instance 1, run: true Oct 04 18:54:02 volumio mpd[1622]: Oct 04 18:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 04 18:54:02 volumio systemd[1]: Started Music Player Daemon. Oct 04 18:54:02 volumio sudo[1566]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:02 volumio volumio[867]: info: camilladsp spawned new process with pid 1708, instance 1, run: true Oct 04 18:54:02 volumio volumio[867]: Upnp client error: Error: This socket has been ended by the other party Oct 04 18:54:02 volumio volumio[867]: error: MPD error: The expression evaluated to a falsy value: Oct 04 18:54:02 volumio volumio[867]: assert.ok(self.idling) Oct 04 18:54:02 volumio volumio[867]: error: The expression evaluated to a falsy value: Oct 04 18:54:02 volumio volumio[867]: assert.ok(self.idling) Oct 04 18:54:02 volumio volumio[867]: error: MPD error: The expression evaluated to a falsy value: Oct 04 18:54:02 volumio volumio[867]: assert.ok(self.idling) Oct 04 18:54:02 volumio volumio[867]: error: The expression evaluated to a falsy value: Oct 04 18:54:02 volumio volumio[867]: assert.ok(self.idling) Oct 04 18:54:02 volumio volumio[867]: error: updateQueue error: null Oct 04 18:54:02 volumio volumio[867]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 04 18:54:02 volumio volumio[867]: info: camilladsp spawned new process with pid 1717, instance 1, run: true Oct 04 18:54:02 volumio volumio[867]: info: Initializing connection to go-librespot Websocket Oct 04 18:54:02 volumio volumio[867]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 04 18:54:02 volumio sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 04 18:54:02 volumio sudo[1727]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:54:02 volumio volumio[867]: info: camilladsp spawned new process with pid 1728, instance 1, run: true Oct 04 18:54:02 volumio sudo[1727]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:02 volumio volumio[867]: info: camilladsp spawned new process with pid 1736, instance 1, run: true Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1744, instance 1, run: true Oct 04 18:54:03 volumio volumio[867]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1751, instance 1, run: true Oct 04 18:54:03 volumio RoonBridge[1414]: 00:00:09.056 Warn: exception starting raatserver: System.Net.Sockets.SocketException (0x80004005): Connection refused Oct 04 18:54:03 volumio RoonBridge[1414]: at System.Net.Sockets.TcpClient..ctor (System.String hostname, System.Int32 port) [0x0006d] in <08911f3881ec4a92acc8fdc4d13b73bf>:0 Oct 04 18:54:03 volumio RoonBridge[1414]: at Sooloos.RAATServer.ConnectOrStartAndWaitForExit (System.String path, System.String args, System.Action`1[T] status, Base.ChildProcess& p) [0x00165] in <5529660cb9214b5a92e49e1607b30d50>:0 Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1758, instance 1, run: true Oct 04 18:54:03 volumio RoonBridge[1414]: Not Running (.o) Oct 04 18:54:03 volumio RoonBridge[1414]: 00:00:09.138 Debug: PathForResource, filename: ../.update Oct 04 18:54:03 volumio RoonBridge[1414]: 00:00:09.138 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Oct 04 18:54:03 volumio volumio[867]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 04 18:54:03 volumio volumio[1604]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1780, instance 1, run: true Oct 04 18:54:03 volumio sudo[1769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 04 18:54:03 volumio sudo[1769]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:54:03 volumio sudo[1769]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1790, instance 1, run: true Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1797, instance 1, run: true Oct 04 18:54:03 volumio volumio[867]: info: camilladsp spawned new process with pid 1805, instance 1, run: true Oct 04 18:54:04 volumio volumio[867]: info: camilladsp spawned new process with pid 1813, instance 1, run: true Oct 04 18:54:04 volumio volumio[867]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 04 18:54:04 volumio sudo[1821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 04 18:54:04 volumio sudo[1821]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:54:04 volumio volumio[867]: info: camilladsp spawned new process with pid 1822, instance 1, run: true Oct 04 18:54:04 volumio sudo[1821]: pam_unix(sudo:session): session closed for user root Oct 04 18:54:04 volumio volumio[867]: info: Completed starting Core Plugins Oct 04 18:54:04 volumio volumio[867]: info: ------------------------------------------- Oct 04 18:54:04 volumio volumio[867]: info: ----- MyVolumio plugins startup ---- Oct 04 18:54:04 volumio volumio[867]: info: ------------------------------------------- Oct 04 18:54:04 volumio volumio[867]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 04 18:54:04 volumio volumio[867]: info: camilladsp spawned new process with pid 1830, instance 1, run: true Oct 04 18:54:04 volumio volumio[867]: info: camilladsp spawned new process with pid 1839, instance 1, run: true Oct 04 18:54:04 volumio volumio[867]: info: camilladsp spawned new process with pid 1846, instance 1, run: true Oct 04 18:54:04 volumio volumio[867]: info: camilladsp spawned new process with pid 1853, instance 1, run: true Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1860, instance 1, run: true Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1869, instance 1, run: true Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1876, instance 1, run: true Oct 04 18:54:05 volumio RoonBridge[1414]: 00:00:11.150 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 04 18:54:05 volumio RoonBridge[1414]: Running Oct 04 18:54:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1889, instance 1, run: true Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1897, instance 1, run: true Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1905, instance 1, run: true Oct 04 18:54:05 volumio volumio[867]: info: camilladsp spawned new process with pid 1912, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1920, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1931, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1942, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1949, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1958, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1965, instance 1, run: true Oct 04 18:54:06 volumio volumio[867]: info: camilladsp spawned new process with pid 1972, instance 1, run: true Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 1981, instance 1, run: true Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 1995, instance 1, run: true Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 2003, instance 1, run: true Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 2016, instance 1, run: true Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 2023, instance 1, run: true Oct 04 18:54:07 volumio volumio[1604]: .................................................................................................++++ Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 2030, instance 1, run: true Oct 04 18:54:07 volumio volumio[867]: info: camilladsp spawned new process with pid 2043, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2060, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2077, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2094, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2110, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2124, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2134, instance 1, run: true Oct 04 18:54:08 volumio volumio[867]: info: camilladsp spawned new process with pid 2145, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2161, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2183, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2195, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2207, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2221, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2235, instance 1, run: true Oct 04 18:54:09 volumio volumio[867]: info: camilladsp spawned new process with pid 2248, instance 1, run: true Oct 04 18:54:10 volumio volumio[867]: info: camilladsp spawned new process with pid 2264, instance 1, run: true Oct 04 18:54:10 volumio volumio[867]: info: camilladsp spawned new process with pid 2276, instance 1, run: true Oct 04 18:54:10 volumio volumio[867]: info: camilladsp spawned new process with pid 2300, instance 1, run: true Oct 04 18:54:10 volumio volumio[867]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 04 18:54:10 volumio volumio[867]: info: camilladsp spawned new process with pid 2316, instance 1, run: true Oct 04 18:54:10 volumio volumio[867]: info: camilladsp spawned new process with pid 2331, instance 1, run: true Oct 04 18:54:10 volumio volumio[867]: info: camilladsp spawned new process with pid 2338, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2345, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2352, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2360, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2367, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2375, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2382, instance 1, run: true Oct 04 18:54:11 volumio volumio[867]: info: camilladsp spawned new process with pid 2389, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2397, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2404, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2411, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2419, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2426, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2433, instance 1, run: true Oct 04 18:54:12 volumio volumio[867]: info: camilladsp spawned new process with pid 2440, instance 1, run: true Oct 04 18:54:13 volumio volumio[867]: info: camilladsp spawned new process with pid 2448, instance 1, run: true Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetVisibleSources Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:54:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 04 18:54:13 volumio volumio[867]: info: Received Get System Info Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 04 18:54:13 volumio volumio[867]: info: Discovery: Getting this device information Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:54:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:54:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:54:13 volumio volumio[867]: info: Listing playlists Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 04 18:54:13 volumio volumio[867]: info: Received Get System Info Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 04 18:54:13 volumio volumio[867]: info: Discovery: Getting this device information Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:54:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:54:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 04 18:54:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 04 18:54:13 volumio volumio[867]: info: camilladsp spawned new process with pid 2458, instance 1, run: true Oct 04 18:54:13 volumio volumio[867]: info: camilladsp spawned new process with pid 2466, instance 1, run: true Oct 04 18:54:13 volumio volumio[867]: info: camilladsp spawned new process with pid 2473, instance 1, run: true Oct 04 18:54:13 volumio volumio[867]: info: camilladsp spawned new process with pid 2480, instance 1, run: true Oct 04 18:54:14 volumio volumio[867]: info: camilladsp spawned new process with pid 2487, instance 1, run: true Oct 04 18:54:14 volumio volumio[867]: info: camilladsp spawned new process with pid 2495, instance 1, run: true Oct 04 18:54:14 volumio volumio[867]: info: camilladsp spawned new process with pid 2502, instance 1, run: true Oct 04 18:54:14 volumio volumio[867]: info: camilladsp spawned new process with pid 2510, instance 1, run: true Oct 04 18:54:14 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2517, instance 1, run: true Oct 04 18:54:15 volumio go-librespot[1449]: time="2024-10-04T18:54:15+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2524, instance 1, run: true Oct 04 18:54:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 04 18:54:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2531, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2538, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2545, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2552, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2559, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2566, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2573, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2580, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2587, instance 1, run: true Oct 04 18:54:15 volumio volumio[867]: info: camilladsp spawned new process with pid 2594, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2601, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2608, instance 1, run: true Oct 04 18:54:16 volumio volumio[1604]: ............................................................................................................................................................................................................................++++ Oct 04 18:54:16 volumio volumio[1604]: e is 65537 (0x010001) Oct 04 18:54:16 volumio volumio[1604]: writing RSA key Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2624, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2640, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2647, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2656, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2663, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2670, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2677, instance 1, run: true Oct 04 18:54:16 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2686, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2693, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2700, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2707, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2714, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2721, instance 1, run: true Oct 04 18:54:16 volumio volumio[867]: info: camilladsp spawned new process with pid 2728, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2735, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2742, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2749, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2756, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2763, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2770, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2777, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2784, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2791, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2798, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2805, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2812, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2819, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2826, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2833, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2840, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2847, instance 1, run: true Oct 04 18:54:17 volumio volumio[867]: info: camilladsp spawned new process with pid 2854, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2861, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2868, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2875, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2882, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2889, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2896, instance 1, run: true Oct 04 18:54:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 04 18:54:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Oct 04 18:54:18 volumio systemd[1]: Stopped go-librespot Daemon. Oct 04 18:54:18 volumio systemd[1]: Started go-librespot Daemon. Oct 04 18:54:18 volumio go-librespot[2903]: Librespot-go daemon starting... Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2904, instance 1, run: true Oct 04 18:54:18 volumio go-librespot[2903]: time="2024-10-04T18:54:18+07:00" level=info msg="generated new device id: ab0ff67d49ef7ca0993568ccb2cf747eca864312" Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2916, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2923, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2930, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2937, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2944, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2951, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2958, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2965, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2972, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2979, instance 1, run: true Oct 04 18:54:18 volumio volumio[867]: info: camilladsp spawned new process with pid 2988, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 2995, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3002, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3009, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3016, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3023, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3030, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3037, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3044, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3051, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3058, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3065, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3072, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3079, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3086, instance 1, run: true Oct 04 18:54:19 volumio volumio[867]: info: camilladsp spawned new process with pid 3093, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3100, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3107, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3114, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3122, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3129, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3136, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3143, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3150, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3157, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3164, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3172, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3181, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3188, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3195, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3203, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3210, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3217, instance 1, run: true Oct 04 18:54:20 volumio volumio[867]: info: camilladsp spawned new process with pid 3224, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3231, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3238, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3245, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3252, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3259, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3266, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3273, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3280, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3287, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3294, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3301, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3308, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3315, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3322, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3329, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3336, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3343, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3350, instance 1, run: true Oct 04 18:54:21 volumio volumio[867]: info: camilladsp spawned new process with pid 3357, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3364, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3371, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3378, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3385, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3392, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3399, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3406, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3413, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3420, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3427, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3434, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3441, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3448, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3455, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3462, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 04 18:54:22 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:54:22 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3471, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3478, instance 1, run: true Oct 04 18:54:22 volumio volumio[867]: info: camilladsp spawned new process with pid 3485, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3492, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3499, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3506, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3513, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3520, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3527, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3534, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.757&uuid=8ebd5050b785a2503aef664dead42249" http://updates.volumio.org/downloader-v1/track-device Oct 04 18:54:23 volumio volumio[867]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 18:54:23 volumio volumio[867]: Dload Upload Total Spent Left Speed Oct 04 18:54:23 volumio volumio[867]: [1.6K blob data] Oct 04 18:54:23 volumio volumio[867]: retrying in 5 seconds, trial 0 Oct 04 18:54:23 volumio volumio[867]: info: Volumio Calling Home Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3543, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3551, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3558, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3565, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3572, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3579, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3586, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3593, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3600, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3607, instance 1, run: true Oct 04 18:54:23 volumio volumio[867]: info: camilladsp spawned new process with pid 3614, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3621, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3628, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3635, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3642, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3649, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3656, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3663, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: error: MyVolumio Plugin failed to start in a timely fashion Oct 04 18:54:24 volumio volumio[867]: info: BOOT COMPLETED Oct 04 18:54:24 volumio volumio[867]: [Metrics] CommandRouter: 46s 984.89ms Oct 04 18:54:24 volumio volumio[867]: info: CoreCommandRouter::volumiosetStartupVolume Oct 04 18:54:24 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 04 18:54:24 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:54:24 volumio volumio[867]: info: CoreCommandRouter::Close All Modals sent Oct 04 18:54:24 volumio volumio[867]: info: CoreCommandRouter::Close All Modals sent Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3672, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 04 18:54:24 volumio volumio[867]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 04 18:54:24 volumio volumio[867]: info: camilladsp stopping service pid 3672... Oct 04 18:54:24 volumio volumio[867]: info: camilladsp service terminated, instance 1 Oct 04 18:54:24 volumio volumio[867]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 04 18:54:24 volumio volumio[867]: info: camilladsp service started and running in background, instance 1 Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3682, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3689, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3696, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3703, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3710, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3717, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3724, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3731, instance 1, run: true Oct 04 18:54:24 volumio volumio[867]: info: camilladsp spawned new process with pid 3738, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3745, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3752, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3759, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3766, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3773, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3780, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3787, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3794, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 04 18:54:25 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 04 18:54:25 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 04 18:54:25 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3803, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3810, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3817, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3824, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3831, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3838, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3845, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3852, instance 1, run: true Oct 04 18:54:25 volumio volumio[867]: info: camilladsp spawned new process with pid 3859, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3866, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3873, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3880, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3887, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3894, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3901, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3908, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3915, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3922, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3929, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3936, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3943, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3950, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3957, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3964, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3971, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3978, instance 1, run: true Oct 04 18:54:26 volumio volumio[867]: info: camilladsp spawned new process with pid 3985, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 3992, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 3999, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4006, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4013, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4020, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4027, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4034, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4041, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4048, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4055, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4062, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4069, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4076, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4083, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4090, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4097, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4104, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4111, instance 1, run: true Oct 04 18:54:27 volumio volumio[867]: info: camilladsp spawned new process with pid 4118, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4125, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4132, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4139, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4146, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4153, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4160, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4167, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4174, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4181, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4188, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4195, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4202, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4209, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4216, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4223, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4230, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4237, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4244, instance 1, run: true Oct 04 18:54:28 volumio volumio[867]: info: camilladsp spawned new process with pid 4251, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4258, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4265, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4272, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4279, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4286, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4293, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4300, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4307, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4314, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4321, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4328, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4335, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4342, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4349, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4356, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4363, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4370, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4377, instance 1, run: true Oct 04 18:54:29 volumio volumio[867]: info: camilladsp spawned new process with pid 4384, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4391, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4398, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4405, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4412, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4419, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4426, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4433, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4440, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4447, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4454, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4462, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4469, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4476, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4483, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4500, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4519, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4541, instance 1, run: true Oct 04 18:54:30 volumio volumio[867]: info: camilladsp spawned new process with pid 4555, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4562, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4569, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4576, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4583, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4590, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4597, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4604, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4611, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4618, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4625, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4632, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4639, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4646, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4653, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4660, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4667, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4674, instance 1, run: true Oct 04 18:54:31 volumio volumio[867]: info: camilladsp spawned new process with pid 4681, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4688, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4695, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4702, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4709, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4716, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4723, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: Discovery: adding cb6112b6-8b46-4363-b23f-521184e5912c Oct 04 18:54:32 volumio volumio[867]: info: Discovery: Found device Volumio Oct 04 18:54:32 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:54:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4730, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4737, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4744, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4751, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4758, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4765, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4772, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4779, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4786, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4793, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4800, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4807, instance 1, run: true Oct 04 18:54:32 volumio volumio[867]: info: camilladsp spawned new process with pid 4814, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4821, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4828, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4835, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4842, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4849, instance 1, run: true Oct 04 18:54:33 volumio go-librespot[2903]: time="2024-10-04T18:54:33+07:00" level=debug msg="new websocket client" Oct 04 18:54:33 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 04 18:54:33 volumio volumio[867]: info: Connection to go-librespot Websocket established Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4858, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4865, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4872, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4879, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4886, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4893, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4900, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4907, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4914, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4921, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4928, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4936, instance 1, run: true Oct 04 18:54:33 volumio volumio[867]: info: camilladsp spawned new process with pid 4943, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4950, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4957, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4964, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4971, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4978, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4985, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4992, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 4999, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5007, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5014, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5021, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5028, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5035, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5042, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5049, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5056, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5063, instance 1, run: true Oct 04 18:54:34 volumio volumio[867]: info: camilladsp spawned new process with pid 5070, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5077, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5084, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5091, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5098, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5105, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5112, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5119, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5126, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5133, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5140, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5147, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5154, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5161, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5168, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5175, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5182, instance 1, run: true Oct 04 18:54:35 volumio volumio[867]: info: camilladsp spawned new process with pid 5189, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5196, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5203, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5210, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5217, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5224, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5231, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: Getting Spotify volume Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5238, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5245, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5252, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5259, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5266, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5273, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5280, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5287, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5294, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5301, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5308, instance 1, run: true Oct 04 18:54:36 volumio volumio[867]: info: camilladsp spawned new process with pid 5315, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5322, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5329, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5336, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5343, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5350, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5357, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5364, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5371, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5378, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5385, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5392, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5399, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5406, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5413, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5420, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5427, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5434, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5441, instance 1, run: true Oct 04 18:54:37 volumio volumio[867]: info: camilladsp spawned new process with pid 5448, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5455, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5462, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5469, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5476, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5483, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5490, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5497, instance 1, run: true Oct 04 18:54:38 volumio go-librespot[2903]: time="2024-10-04T18:54:38+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Oct 04 18:54:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 04 18:54:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 04 18:54:38 volumio volumio[867]: (node:867) UnhandledPromiseRejectionWarning: Error: socket hang up Oct 04 18:54:38 volumio volumio[867]: at connResetException (internal/errors.js:639:14) Oct 04 18:54:38 volumio volumio[867]: at Socket.socketOnEnd (_http_client.js:499:23) Oct 04 18:54:38 volumio volumio[867]: at Socket.emit (events.js:412:35) Oct 04 18:54:38 volumio volumio[867]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 04 18:54:38 volumio volumio[867]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 04 18:54:38 volumio volumio[867]: (Use `node --trace-warnings ...` to show where the warning was created) Oct 04 18:54:38 volumio volumio[867]: (node:867) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 2) Oct 04 18:54:38 volumio volumio[867]: (node:867) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Oct 04 18:54:38 volumio volumio[867]: info: Connection to go-librespot Websocket closed Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5504, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5511, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5518, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5525, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5532, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5539, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5546, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5553, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5560, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5567, instance 1, run: true Oct 04 18:54:38 volumio volumio[867]: info: camilladsp spawned new process with pid 5574, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5581, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5588, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5595, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5602, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5609, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5616, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5623, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5630, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5637, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5644, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5651, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5658, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5665, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5672, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5679, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5686, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5693, instance 1, run: true Oct 04 18:54:39 volumio volumio[867]: info: camilladsp spawned new process with pid 5700, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5707, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5714, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5721, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5728, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5735, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5742, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5749, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5756, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5763, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5770, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5777, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5784, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5791, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5798, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5805, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5812, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5819, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5826, instance 1, run: true Oct 04 18:54:40 volumio volumio[867]: info: camilladsp spawned new process with pid 5833, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5840, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5847, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5854, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5861, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5868, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5875, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5882, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: Initializing connection to go-librespot Websocket Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5889, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5896, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5903, instance 1, run: true Oct 04 18:54:41 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 04 18:54:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Oct 04 18:54:41 volumio systemd[1]: Stopped go-librespot Daemon. Oct 04 18:54:41 volumio systemd[1]: Started go-librespot Daemon. Oct 04 18:54:41 volumio go-librespot[5910]: Librespot-go daemon starting... Oct 04 18:54:41 volumio go-librespot[5910]: time="2024-10-04T18:54:41+07:00" level=info msg="generated new device id: d03d56468cd5375708e9b956b01d9c9f204cc5cd" Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5916, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5923, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5930, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5937, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5944, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5951, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5958, instance 1, run: true Oct 04 18:54:41 volumio volumio[867]: info: camilladsp spawned new process with pid 5965, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 5972, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 5979, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 5986, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 5993, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6000, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6007, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6014, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6021, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6028, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6035, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6042, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6049, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6056, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6063, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6070, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6077, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6084, instance 1, run: true Oct 04 18:54:42 volumio volumio[867]: info: camilladsp spawned new process with pid 6091, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6098, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6105, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6112, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6119, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6126, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6133, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6140, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6147, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6154, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6161, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6168, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6175, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6182, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6189, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6196, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6203, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6210, instance 1, run: true Oct 04 18:54:43 volumio volumio[867]: info: camilladsp spawned new process with pid 6217, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6224, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6231, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6238, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6245, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6252, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6259, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6266, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6273, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6280, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6287, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6294, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6301, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6308, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6315, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6322, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6329, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6336, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6343, instance 1, run: true Oct 04 18:54:44 volumio volumio[867]: info: camilladsp spawned new process with pid 6350, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6357, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6364, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6371, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6378, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6385, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6392, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6399, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6406, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6413, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6420, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6427, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6434, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6441, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6448, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6455, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6462, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6469, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6476, instance 1, run: true Oct 04 18:54:45 volumio volumio[867]: info: camilladsp spawned new process with pid 6483, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6490, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6497, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6504, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6511, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6518, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6525, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6532, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6539, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6546, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6553, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6560, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6567, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6574, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6581, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6588, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6595, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6602, instance 1, run: true Oct 04 18:54:46 volumio volumio[867]: info: camilladsp spawned new process with pid 6609, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6616, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6623, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6630, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6637, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6644, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6651, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6658, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6665, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6672, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6679, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6686, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6693, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6700, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6707, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6714, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6721, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6728, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6735, instance 1, run: true Oct 04 18:54:47 volumio volumio[867]: info: camilladsp spawned new process with pid 6742, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6749, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6756, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6763, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6770, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6777, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6784, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6791, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6798, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6805, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6812, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6819, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6826, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6833, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6840, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6847, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6854, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6861, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6868, instance 1, run: true Oct 04 18:54:48 volumio volumio[867]: info: camilladsp spawned new process with pid 6875, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6882, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6889, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6896, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6903, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6910, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6917, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6924, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6931, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6938, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6945, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6952, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6959, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6966, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6973, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6980, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6987, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 6994, instance 1, run: true Oct 04 18:54:49 volumio volumio[867]: info: camilladsp spawned new process with pid 7001, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7008, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7015, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7022, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7029, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7036, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7043, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7050, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7057, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7064, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7071, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7078, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7085, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7092, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7099, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7106, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7113, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7120, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7127, instance 1, run: true Oct 04 18:54:50 volumio volumio[867]: info: camilladsp spawned new process with pid 7134, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7141, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7148, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7155, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7162, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7169, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7176, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7183, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7190, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7197, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7204, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7211, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7218, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7225, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7232, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7239, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7246, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7253, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7260, instance 1, run: true Oct 04 18:54:51 volumio volumio[867]: info: camilladsp spawned new process with pid 7267, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7274, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7281, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7288, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7295, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7302, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7309, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7316, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7323, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7330, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7337, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7344, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7351, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7358, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7365, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7372, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7379, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7386, instance 1, run: true Oct 04 18:54:52 volumio volumio[867]: info: camilladsp spawned new process with pid 7393, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7400, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7407, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7414, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7421, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7428, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7435, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7442, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7449, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7456, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7463, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.757&uuid=8ebd5050b785a2503aef664dead42249" http://updates.volumio.org/downloader-v1/track-device Oct 04 18:54:53 volumio volumio[867]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 18:54:53 volumio volumio[867]: Dload Upload Total Spent Left Speed Oct 04 18:54:53 volumio volumio[867]: [1.6K blob data] Oct 04 18:54:53 volumio volumio[867]: retrying in 5 seconds, trial 1 Oct 04 18:54:53 volumio volumio[867]: info: Volumio Calling Home Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7472, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7480, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7487, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7494, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7501, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7508, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7515, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7522, instance 1, run: true Oct 04 18:54:53 volumio volumio[867]: info: camilladsp spawned new process with pid 7529, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7536, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7543, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7550, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7557, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7564, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7571, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7578, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7585, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7592, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7599, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7606, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7613, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7620, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7627, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7634, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7641, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7648, instance 1, run: true Oct 04 18:54:54 volumio volumio[867]: info: camilladsp spawned new process with pid 7655, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7662, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7669, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7676, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7683, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7690, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7697, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7704, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7711, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7718, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7725, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7732, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7739, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7746, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7753, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7761, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7768, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7775, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7782, instance 1, run: true Oct 04 18:54:55 volumio volumio[867]: info: camilladsp spawned new process with pid 7789, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7796, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7803, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7810, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7818, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7825, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7832, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7839, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7846, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7853, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7860, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7867, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7874, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7881, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7888, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7895, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7902, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7909, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7916, instance 1, run: true Oct 04 18:54:56 volumio volumio[867]: info: camilladsp spawned new process with pid 7923, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7930, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7937, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7944, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7951, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7958, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7965, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7972, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7979, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7986, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 7993, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8000, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8007, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8014, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8021, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8028, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8035, instance 1, run: true Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8042, instance 1, run: true Oct 04 18:54:57 volumio ntpd[813]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 04 18:54:57 volumio volumio[867]: info: camilladsp spawned new process with pid 8049, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8056, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8063, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8070, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8077, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8084, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8091, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8098, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8105, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8112, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8119, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8126, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8133, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8140, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8147, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8154, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8161, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8168, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8175, instance 1, run: true Oct 04 18:54:58 volumio volumio[867]: info: camilladsp spawned new process with pid 8182, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8189, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8196, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8203, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8210, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8217, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8224, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8231, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8238, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8245, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8252, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8259, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8266, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8273, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8280, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8287, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8294, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8301, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8308, instance 1, run: true Oct 04 18:54:59 volumio volumio[867]: info: camilladsp spawned new process with pid 8315, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8322, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8329, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8336, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8343, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8350, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8357, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8364, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8371, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8378, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8385, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8392, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8399, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8406, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8413, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8420, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8427, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8434, instance 1, run: true Oct 04 18:55:00 volumio volumio[867]: info: camilladsp spawned new process with pid 8441, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8448, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8455, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8462, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8469, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8476, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8483, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8490, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8497, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8504, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8511, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8518, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8525, instance 1, run: true Oct 04 18:55:01 volumio go-librespot[5910]: time="2024-10-04T18:55:01+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Oct 04 18:55:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 04 18:55:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8532, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8539, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8546, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8553, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8560, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8567, instance 1, run: true Oct 04 18:55:01 volumio volumio[867]: info: camilladsp spawned new process with pid 8574, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8581, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8588, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8595, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8602, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8609, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8616, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8623, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8630, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8637, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8644, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8651, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8658, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8665, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8672, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8679, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8686, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8693, instance 1, run: true Oct 04 18:55:02 volumio volumio[867]: info: camilladsp spawned new process with pid 8700, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8707, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8714, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8721, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8728, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8735, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8742, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8749, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8756, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8763, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8770, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8777, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8784, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8791, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8798, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8805, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8812, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8819, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8826, instance 1, run: true Oct 04 18:55:03 volumio volumio[867]: info: camilladsp spawned new process with pid 8833, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8840, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8847, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8854, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8861, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8868, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8875, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8882, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8889, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8896, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8903, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8910, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8917, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8924, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8931, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8938, instance 1, run: true Oct 04 18:55:04 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 04 18:55:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Oct 04 18:55:04 volumio systemd[1]: Stopped go-librespot Daemon. Oct 04 18:55:04 volumio systemd[1]: Started go-librespot Daemon. Oct 04 18:55:04 volumio go-librespot[8945]: Librespot-go daemon starting... Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8946, instance 1, run: true Oct 04 18:55:04 volumio go-librespot[8945]: time="2024-10-04T18:55:04+07:00" level=info msg="generated new device id: e155a9b3c072df1bf3e85e50c93807ddf4d9b434" Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8958, instance 1, run: true Oct 04 18:55:04 volumio volumio[867]: info: camilladsp spawned new process with pid 8965, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 8972, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 8979, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 8986, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 8993, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9000, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9007, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9014, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9021, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9028, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9035, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9042, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9049, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9056, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9063, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9070, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9077, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9084, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9091, instance 1, run: true Oct 04 18:55:05 volumio volumio[867]: info: camilladsp spawned new process with pid 9098, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9105, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9112, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9119, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9126, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9133, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9140, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9147, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9154, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9161, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9168, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9175, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9182, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9189, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9196, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9203, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9210, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9217, instance 1, run: true Oct 04 18:55:06 volumio volumio[867]: info: camilladsp spawned new process with pid 9224, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9231, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9238, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9245, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9252, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9259, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9266, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9273, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9280, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9287, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9294, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9301, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9308, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9315, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9322, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9329, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9336, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9343, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9350, instance 1, run: true Oct 04 18:55:07 volumio volumio[867]: info: camilladsp spawned new process with pid 9357, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9364, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9371, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9378, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9385, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9392, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9399, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9406, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9413, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9420, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9427, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9434, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9441, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9448, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9455, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9462, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9469, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9476, instance 1, run: true Oct 04 18:55:08 volumio volumio[867]: info: camilladsp spawned new process with pid 9483, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9490, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9497, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9504, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9511, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9518, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9525, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9532, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9539, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9546, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9553, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9560, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9567, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9574, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9581, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9588, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9595, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9602, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9609, instance 1, run: true Oct 04 18:55:09 volumio volumio[867]: info: camilladsp spawned new process with pid 9616, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9623, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9630, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9637, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9644, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9654, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9661, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9668, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9675, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9682, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9689, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9696, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9703, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9710, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9717, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9724, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9731, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9738, instance 1, run: true Oct 04 18:55:10 volumio volumio[867]: info: camilladsp spawned new process with pid 9745, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9752, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9759, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9766, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9773, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9780, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9787, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9794, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9801, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9808, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9815, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9822, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9829, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9836, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9843, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9850, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9857, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9864, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9871, instance 1, run: true Oct 04 18:55:11 volumio volumio[867]: info: camilladsp spawned new process with pid 9878, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9885, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9892, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9899, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9906, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9913, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9920, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9927, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9934, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9941, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9948, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9955, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9962, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9969, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9976, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9983, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9990, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 9997, instance 1, run: true Oct 04 18:55:12 volumio volumio[867]: info: camilladsp spawned new process with pid 10004, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10011, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10018, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10025, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10032, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10039, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10046, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10053, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10060, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10067, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10074, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10081, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10088, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10095, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10102, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10109, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10116, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10123, instance 1, run: true Oct 04 18:55:13 volumio volumio[867]: info: camilladsp spawned new process with pid 10130, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10137, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10144, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10151, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10158, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10165, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10172, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10179, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10186, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10193, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10200, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10207, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10214, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10221, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10228, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10235, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10242, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10249, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10256, instance 1, run: true Oct 04 18:55:14 volumio volumio[867]: info: camilladsp spawned new process with pid 10263, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10270, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10277, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10284, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10291, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10298, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10305, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10312, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10319, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10326, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10333, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10340, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10347, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10354, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10361, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10368, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10375, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10382, instance 1, run: true Oct 04 18:55:15 volumio volumio[867]: info: camilladsp spawned new process with pid 10389, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10396, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10403, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10410, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10417, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10424, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10431, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10438, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10445, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10452, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10459, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10466, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10473, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10480, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10487, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10494, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10501, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10508, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10515, instance 1, run: true Oct 04 18:55:16 volumio volumio[867]: info: camilladsp spawned new process with pid 10522, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10529, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10536, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10543, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10550, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10557, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10564, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10571, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10578, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10585, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10592, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10599, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10606, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10613, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10620, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10627, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10634, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10641, instance 1, run: true Oct 04 18:55:17 volumio volumio[867]: info: camilladsp spawned new process with pid 10648, instance 1, run: true Oct 04 18:55:17 volumio ntpd[813]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10655, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10662, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10669, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10676, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10683, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10690, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10697, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10704, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10711, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10718, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10725, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10732, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10739, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10746, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10753, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10760, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10767, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10774, instance 1, run: true Oct 04 18:55:18 volumio volumio[867]: info: camilladsp spawned new process with pid 10781, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10788, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10795, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10802, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10809, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10816, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10823, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10830, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10837, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10844, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10851, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10858, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10865, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10872, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10879, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10886, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10893, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10900, instance 1, run: true Oct 04 18:55:19 volumio volumio[867]: info: camilladsp spawned new process with pid 10907, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10914, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10921, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10928, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10935, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10942, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10949, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10956, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10963, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10970, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10977, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10984, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10991, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 10998, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 11005, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 11012, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 11019, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 11026, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 11033, instance 1, run: true Oct 04 18:55:20 volumio volumio[867]: info: camilladsp spawned new process with pid 11040, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11047, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11054, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11061, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11068, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11075, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11082, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11089, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11096, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11103, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11110, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11117, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11124, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11131, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11138, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11145, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11152, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11159, instance 1, run: true Oct 04 18:55:21 volumio volumio[867]: info: camilladsp spawned new process with pid 11166, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11173, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11180, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11187, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11194, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11201, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11208, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11215, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11222, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11229, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11236, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11243, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11250, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11257, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11264, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11271, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11278, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11285, instance 1, run: true Oct 04 18:55:22 volumio volumio[867]: info: camilladsp spawned new process with pid 11292, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11299, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11306, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11313, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11320, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11327, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11334, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11341, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11348, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11355, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11362, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11369, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.757&uuid=8ebd5050b785a2503aef664dead42249" http://updates.volumio.org/downloader-v1/track-device Oct 04 18:55:23 volumio volumio[867]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 04 18:55:23 volumio volumio[867]: Dload Upload Total Spent Left Speed Oct 04 18:55:23 volumio volumio[867]: [1.6K blob data] Oct 04 18:55:23 volumio volumio[867]: retrying in 5 seconds, trial 2 Oct 04 18:55:23 volumio volumio[867]: info: Volumio Calling Home Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11378, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11386, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11393, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11400, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11407, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11414, instance 1, run: true Oct 04 18:55:23 volumio volumio[867]: info: camilladsp spawned new process with pid 11421, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11428, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11435, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11442, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11449, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11456, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11463, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11470, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11477, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11484, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11491, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11498, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11505, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11512, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11519, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11526, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11533, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11540, instance 1, run: true Oct 04 18:55:24 volumio go-librespot[8945]: time="2024-10-04T18:55:24+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Oct 04 18:55:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 04 18:55:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11547, instance 1, run: true Oct 04 18:55:24 volumio volumio[867]: info: camilladsp spawned new process with pid 11554, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11561, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11568, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11575, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11582, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11589, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11596, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11603, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11610, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11617, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11624, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11631, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11638, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11645, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11652, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11659, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11666, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11673, instance 1, run: true Oct 04 18:55:25 volumio volumio[867]: info: camilladsp spawned new process with pid 11680, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11687, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11694, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11701, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11708, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11715, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11722, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11729, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11736, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11743, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11750, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11757, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11764, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11771, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11778, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11785, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11792, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11799, instance 1, run: true Oct 04 18:55:26 volumio volumio[867]: info: camilladsp spawned new process with pid 11806, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11813, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11820, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11827, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11834, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11841, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11848, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11855, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11862, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11869, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11876, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11883, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11890, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11897, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11904, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11911, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11918, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11925, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11932, instance 1, run: true Oct 04 18:55:27 volumio volumio[867]: info: camilladsp spawned new process with pid 11939, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11946, instance 1, run: true Oct 04 18:55:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 04 18:55:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Oct 04 18:55:28 volumio systemd[1]: Stopped go-librespot Daemon. Oct 04 18:55:28 volumio systemd[1]: Started go-librespot Daemon. Oct 04 18:55:28 volumio go-librespot[11953]: Librespot-go daemon starting... Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11954, instance 1, run: true Oct 04 18:55:28 volumio go-librespot[11953]: time="2024-10-04T18:55:28+07:00" level=info msg="generated new device id: 880143c93550b1eb3418f67d07af79c00e2e9357" Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11966, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11973, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11980, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11987, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 11994, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12001, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12008, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12015, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12022, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12029, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12036, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12043, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12050, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12057, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12064, instance 1, run: true Oct 04 18:55:28 volumio volumio[867]: info: camilladsp spawned new process with pid 12071, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12078, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12085, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12092, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12099, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12106, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12113, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12120, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12127, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12134, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12141, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12148, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12155, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12162, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12169, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12176, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12183, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12190, instance 1, run: true Oct 04 18:55:29 volumio volumio[867]: info: camilladsp spawned new process with pid 12197, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12204, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12211, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12218, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12225, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12232, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12239, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12246, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12253, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12260, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12267, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12274, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12281, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12288, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12295, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12302, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12309, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12316, instance 1, run: true Oct 04 18:55:30 volumio volumio[867]: info: camilladsp spawned new process with pid 12323, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12340, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12361, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12381, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12395, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12402, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12409, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12416, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12423, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12430, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12437, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12444, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12451, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12458, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12465, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12472, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12479, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12486, instance 1, run: true Oct 04 18:55:31 volumio volumio[867]: info: camilladsp spawned new process with pid 12493, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12500, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12507, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12514, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12521, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12528, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12535, instance 1, run: true Oct 04 18:55:32 volumio go-librespot[11953]: time="2024-10-04T18:55:32+07:00" level=debug msg="new websocket client" Oct 04 18:55:32 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 04 18:55:32 volumio volumio[867]: info: Connection to go-librespot Websocket established Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12542, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12549, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12556, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12563, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12570, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12577, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12584, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12591, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12598, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12605, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12612, instance 1, run: true Oct 04 18:55:32 volumio volumio[867]: info: camilladsp spawned new process with pid 12619, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12626, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12633, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12640, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12647, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12654, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12661, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12668, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12675, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12682, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12689, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12696, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12703, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12710, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12717, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12724, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12731, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12738, instance 1, run: true Oct 04 18:55:33 volumio volumio[867]: info: camilladsp spawned new process with pid 12745, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12752, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12759, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12766, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12773, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12780, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12787, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12794, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12801, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12808, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12815, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12822, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12829, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12836, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12843, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12850, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12857, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12864, instance 1, run: true Oct 04 18:55:34 volumio volumio[867]: info: camilladsp spawned new process with pid 12871, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12878, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12885, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12892, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12899, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12906, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12913, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12920, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: Getting Spotify volume Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12927, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12934, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12941, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12948, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12955, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12962, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12969, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12976, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12983, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12990, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 12997, instance 1, run: true Oct 04 18:55:35 volumio volumio[867]: info: camilladsp spawned new process with pid 13004, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13011, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13018, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13025, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13032, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13040, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13047, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13054, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13061, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13068, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13075, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13082, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13089, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13096, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13103, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13110, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13117, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13124, instance 1, run: true Oct 04 18:55:36 volumio volumio[867]: info: camilladsp spawned new process with pid 13131, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13138, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13145, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13152, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13159, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13166, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13173, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13180, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13187, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13194, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13201, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13208, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13215, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13222, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13229, instance 1, run: true Oct 04 18:55:37 volumio volumio[867]: info: camilladsp spawned new process with pid 13236, instance 1, run: true Oct 04 18:55:37 volumio ntpd[813]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13243, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13250, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13257, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13264, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13271, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13278, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13285, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13292, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13299, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13306, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13313, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13320, instance 1, run: true Oct 04 18:55:38 volumio dhcpcd[731]: eth0: offered 192.168.110.79 from 192.168.110.1 Oct 04 18:55:38 volumio dhcpcd[731]: eth0: probing address 192.168.110.79/24 Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13327, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13334, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13341, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13348, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13355, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13362, instance 1, run: true Oct 04 18:55:38 volumio volumio[867]: info: camilladsp spawned new process with pid 13369, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13376, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13383, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13390, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13397, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13404, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13411, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13418, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13425, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13432, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13439, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13446, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13453, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13460, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13467, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13474, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13481, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13488, instance 1, run: true Oct 04 18:55:39 volumio volumio[867]: info: camilladsp spawned new process with pid 13495, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13502, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13509, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13516, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13523, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13530, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13537, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13544, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13551, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13558, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13565, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13572, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13579, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13586, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13593, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13600, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13607, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13614, instance 1, run: true Oct 04 18:55:40 volumio volumio[867]: info: camilladsp spawned new process with pid 13621, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13629, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13636, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13643, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13650, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13657, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13664, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13671, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13678, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13685, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13692, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13699, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13706, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13713, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13720, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13727, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13734, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13741, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13748, instance 1, run: true Oct 04 18:55:41 volumio volumio[867]: info: camilladsp spawned new process with pid 13755, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13762, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13769, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13776, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13783, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13790, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13797, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13804, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13811, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13818, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13825, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13832, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13839, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13846, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13853, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13860, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13867, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13874, instance 1, run: true Oct 04 18:55:42 volumio volumio[867]: info: camilladsp spawned new process with pid 13881, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13888, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13895, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13902, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13909, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13916, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13923, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13930, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13937, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13944, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13951, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13958, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13965, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13972, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13979, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13986, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 13993, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 14000, instance 1, run: true Oct 04 18:55:43 volumio volumio[867]: info: camilladsp spawned new process with pid 14007, instance 1, run: true Oct 04 18:55:43 volumio dhcpcd[731]: eth0: leased 192.168.110.79 for 1800 seconds Oct 04 18:55:43 volumio avahi-daemon[625]: Registering new address record for 192.168.110.79 on eth0.IPv4. Oct 04 18:55:43 volumio dhcpcd[731]: eth0: adding route to 192.168.110.0/24 Oct 04 18:55:43 volumio dhcpcd[731]: eth0: changing default route via 192.168.110.1 Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14035, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14051, instance 1, run: true Oct 04 18:55:44 volumio ntpd[813]: ntpd exiting on signal 15 (Terminated) Oct 04 18:55:44 volumio systemd[1]: Stopping Network Time Service... Oct 04 18:55:44 volumio systemd[1]: ntp.service: Succeeded. Oct 04 18:55:44 volumio systemd[1]: Stopped Network Time Service. Oct 04 18:55:44 volumio systemd[1]: Starting Network Time Service... Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14063, instance 1, run: true Oct 04 18:55:44 volumio ntpd[14062]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 04 18:55:44 volumio ntpd[14062]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 04 18:55:44 volumio systemd[1]: Started Network Time Service. Oct 04 18:55:44 volumio ntpd[14076]: proto: precision = 0.192 usec (-22) Oct 04 18:55:44 volumio ntpd[14076]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 04 18:55:44 volumio ntpd[14076]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 04 18:55:44 volumio ntpd[14076]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 647 days ago Oct 04 18:55:44 volumio dhcpcd[731]: eth0: deleting route to 169.254.0.0/16 Oct 04 18:55:44 volumio avahi-daemon[625]: Withdrawing address record for 169.254.211.59 on eth0. Oct 04 18:55:44 volumio avahi-daemon[625]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.211.59. Oct 04 18:55:44 volumio avahi-daemon[625]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.110.79. Oct 04 18:55:44 volumio ntpd[14076]: Listen and drop on 0 v6wildcard [::]:123 Oct 04 18:55:44 volumio ntpd[14076]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 04 18:55:44 volumio ntpd[14076]: Listen normally on 2 lo 127.0.0.1:123 Oct 04 18:55:44 volumio ntpd[14076]: Listen normally on 3 eth0 192.168.110.79:123 Oct 04 18:55:44 volumio ntpd[14076]: Listening on routing socket on fd #20 for interface updates Oct 04 18:55:44 volumio ntpd[14076]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 04 18:55:44 volumio ntpd[14076]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14077, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14100, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14107, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14114, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14121, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14128, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14135, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14142, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14149, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14156, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14163, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14170, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14177, instance 1, run: true Oct 04 18:55:44 volumio volumio[867]: info: camilladsp spawned new process with pid 14184, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14191, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14198, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14205, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14212, instance 1, run: true Oct 04 18:55:45 volumio ntpd[14076]: Soliciting pool server 203.113.174.44 Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14219, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14226, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14233, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14240, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14247, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14254, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14261, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14268, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14275, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14282, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14289, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14296, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14303, instance 1, run: true Oct 04 18:55:45 volumio volumio[867]: info: camilladsp spawned new process with pid 14310, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14317, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14324, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14331, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14338, instance 1, run: true Oct 04 18:55:46 volumio ntpd[14076]: Soliciting pool server 115.165.161.155 Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14345, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14352, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14359, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14366, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14373, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14380, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14387, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14394, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14401, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14408, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14415, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14422, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14429, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14436, instance 1, run: true Oct 04 18:55:46 volumio volumio[867]: info: camilladsp spawned new process with pid 14443, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14450, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14457, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14464, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14471, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14482, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14491, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14498, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14505, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14512, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14519, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14526, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 04 18:55:47 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14533, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:55:47 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14540, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14547, instance 1, run: true Oct 04 18:55:47 volumio volumio[867]: info: camilladsp spawned new process with pid 14554, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14561, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14568, instance 1, run: true Oct 04 18:55:48 volumio ntpd[14076]: Soliciting pool server 103.184.124.23 Oct 04 18:55:48 volumio ntpd[14076]: Soliciting pool server 115.165.161.155 Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14575, instance 1, run: true Oct 04 18:55:48 volumio go-librespot[11953]: time="2024-10-04T18:55:48+07:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Oct 04 18:55:48 volumio volumio[867]: (node:867) UnhandledPromiseRejectionWarning: Error: socket hang up Oct 04 18:55:48 volumio volumio[867]: at connResetException (internal/errors.js:639:14) Oct 04 18:55:48 volumio volumio[867]: at Socket.socketOnEnd (_http_client.js:499:23) Oct 04 18:55:48 volumio volumio[867]: at Socket.emit (events.js:412:35) Oct 04 18:55:48 volumio volumio[867]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 04 18:55:48 volumio volumio[867]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 04 18:55:48 volumio volumio[867]: (node:867) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 3) Oct 04 18:55:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 04 18:55:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 04 18:55:48 volumio volumio[867]: info: Connection to go-librespot Websocket closed Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14582, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14589, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14596, instance 1, run: true Oct 04 18:55:48 volumio ntpd[14076]: Soliciting pool server 115.165.161.155 Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14603, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14610, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14617, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14624, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14631, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 04 18:55:48 volumio volumio[867]: info: Received Get System Info Oct 04 18:55:48 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 04 18:55:48 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 04 18:55:48 volumio volumio[867]: info: Discovery: Getting this device information Oct 04 18:55:48 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:55:48 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:55:48 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14638, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14645, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14652, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14659, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14666, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14673, instance 1, run: true Oct 04 18:55:48 volumio volumio[867]: info: camilladsp spawned new process with pid 14680, instance 1, run: true Oct 04 18:55:49 volumio volumio[867]: info: camilladsp spawned new process with pid 14687, instance 1, run: true Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 04 18:55:49 volumio volumio[867]: info: Adding plugin bluetooth to MyMusic Plugins Oct 04 18:55:49 volumio volumio[867]: info: Adding plugin multiroom to MyMusic Plugins Oct 04 18:55:49 volumio volumio[867]: info: Adding plugin metavolumio to MyMusic Plugins Oct 04 18:55:49 volumio volumio[867]: info: Adding plugin cd_controller to MyMusic Plugins Oct 04 18:55:49 volumio volumio[867]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 04 18:55:49 volumio volumio[867]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 04 18:55:49 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 04 18:55:50 volumio volumio[867]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 04 18:55:50 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 04 18:55:50 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:55:50 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:55:50 volumio volumio[867]: info: Starting MyVolumio Remote Streaming Endpoints Oct 04 18:55:50 volumio volumio[867]: info: MyVolumio login type: Token Oct 04 18:55:50 volumio volumio[867]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 04 18:55:50 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 04 18:55:51 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Oct 04 18:55:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Oct 04 18:55:51 volumio systemd[1]: Stopped go-librespot Daemon. Oct 04 18:55:51 volumio systemd[1]: Started go-librespot Daemon. Oct 04 18:55:51 volumio go-librespot[14695]: Librespot-go daemon starting... Oct 04 18:55:51 volumio go-librespot[14695]: time="2024-10-04T18:55:51+07:00" level=info msg="generated new device id: 2641fffd51fa2e54eb334214367a7cb1ef7d2786" Oct 04 18:55:51 volumio go-librespot[14695]: time="2024-10-04T18:55:51+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 04 18:55:51 volumio go-librespot[14695]: time="2024-10-04T18:55:51+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 04 18:55:51 volumio go-librespot[14695]: time="2024-10-04T18:55:51+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 04 18:55:51 volumio go-librespot[14695]: time="2024-10-04T18:55:51+07:00" level=debug msg="zeroconf server listening on port 39899" Oct 04 18:55:51 volumio volumio[867]: info: Starting Streaming Service Transparent Proxy Oct 04 18:55:51 volumio volumio[867]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 04 18:55:51 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 04 18:55:51 volumio volumio[867]: info: Streaming services startup Oct 04 18:55:51 volumio volumio[867]: info: Starting Streaming Daemon Oct 04 18:55:51 volumio sudo[14710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 04 18:55:51 volumio sudo[14710]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:55:51 volumio sudo[14710]: pam_unix(sudo:session): session closed for user root Oct 04 18:55:51 volumio volumio[867]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 04 18:55:51 volumio volumio[867]: info: Initializing connection to go-librespot Websocket Oct 04 18:55:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 04 18:55:51 volumio volumio[867]: info: MyVolumio login type: Token Oct 04 18:55:52 volumio volumio[867]: error: Cannot start Volumio Streaming Daemon Oct 04 18:55:52 volumio volumio[867]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 04 18:55:52 volumio volumio[867]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 04 18:55:52 volumio go-librespot[14695]: time="2024-10-04T18:55:52+07:00" level=debug msg="new websocket client" Oct 04 18:55:52 volumio volumio[867]: info: camilladsp spawned new process with pid 14716, instance 1, run: true Oct 04 18:55:52 volumio volumio[867]: info: Connection to go-librespot Websocket established Oct 04 18:55:52 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 04 18:55:52 volumio volumio[867]: info: camilladsp spawned new process with pid 14724, instance 1, run: true Oct 04 18:55:52 volumio volumio[867]: info: camilladsp spawned new process with pid 14732, instance 1, run: true Oct 04 18:55:52 volumio volumio[867]: error: MyVolumio Custom Token format not valid, refreshing it Oct 04 18:55:52 volumio volumio[867]: info: camilladsp spawned new process with pid 14739, instance 1, run: true Oct 04 18:55:52 volumio volumio[867]: info: camilladsp spawned new process with pid 14746, instance 1, run: true Oct 04 18:55:52 volumio volumio[867]: info: camilladsp spawned new process with pid 14753, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14760, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 04 18:55:53 volumio volumio[867]: STREAMING PROXY: Starting server on port 3245 Oct 04 18:55:53 volumio volumio[867]: Node JS runtime: 14 Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14767, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14774, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14781, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14788, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14795, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14802, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: MyVolumio login type: Token Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14811, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: MyVolumio token set successfully Oct 04 18:55:53 volumio volumio[867]: info: MYVOLUMIO: Adding device Oct 04 18:55:53 volumio volumio[867]: info: MYVOLUMIO: Evaluating Server Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14818, instance 1, run: true Oct 04 18:55:53 volumio volumio[867]: info: camilladsp spawned new process with pid 14825, instance 1, run: true Oct 04 18:55:54 volumio volumio[867]: info: camilladsp spawned new process with pid 14832, instance 1, run: true Oct 04 18:55:54 volumio volumio[867]: info: camilladsp spawned new process with pid 14839, instance 1, run: true Oct 04 18:55:54 volumio volumio[867]: info: MyVolumio Plan changed: premium Oct 04 18:55:54 volumio volumio[867]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Oct 04 18:55:54 volumio volumio[867]: info: Removing browser output: myVolumio user plan is not superstar Oct 04 18:55:54 volumio volumio[867]: info: Removing audio output: Oct 04 18:55:54 volumio volumio[867]: info: MYVOLUMIO: Adding device Oct 04 18:55:54 volumio volumio[867]: info: MYVOLUMIO: Evaluating Server Oct 04 18:55:54 volumio volumio[867]: info: camilladsp spawned new process with pid 14861, instance 1, run: true Oct 04 18:55:54 volumio volumio[867]: info: Remote config written successfully Oct 04 18:55:54 volumio volumio[867]: info: Starting Tunnel 1 Oct 04 18:55:54 volumio volumio[867]: info: Starting Tunnel Connection Checker Oct 04 18:55:54 volumio volumio[867]: info: camilladsp spawned new process with pid 14868, instance 1, run: true Oct 04 18:55:54 volumio volumio[867]: info: camilladsp spawned new process with pid 14875, instance 1, run: true Oct 04 18:55:54 volumio volumio[867]: info: Setting Geolocation for MyVolumio to as1 Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 18:55:54 volumio volumio[867]: info: Getting Spotify volume Oct 04 18:55:54 volumio volumio[867]: info: MYVolumio Device disabled Oct 04 18:55:54 volumio volumio[867]: info: MyVolumio status changed Oct 04 18:55:54 volumio volumio[867]: info: Streaming services startup Oct 04 18:55:54 volumio volumio[867]: info: Starting Streaming Daemon Oct 04 18:55:54 volumio sudo[14899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 04 18:55:54 volumio sudo[14899]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 04 18:55:54 volumio volumio[867]: info: Received Get System Info Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 04 18:55:54 volumio volumio[867]: info: Discovery: Getting this device information Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Oct 04 18:55:54 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Oct 04 18:55:54 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 04 18:55:54 volumio volumio[867]: error: Failed to ping endpoint eu4.myvolumio.org : unknown error Oct 04 18:55:54 volumio volumio[867]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 18:55:54 volumio sudo[14899]: pam_unix(sudo:session): session closed for user root Oct 04 18:55:54 volumio volumio[867]: Error: Unable to resolve or reject the same promise twice Oct 04 18:55:54 volumio volumio[867]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 04 18:55:54 volumio volumio[867]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Oct 04 18:55:54 volumio volumio[867]: at Socket.emit (events.js:400:28) Oct 04 18:55:54 volumio volumio[867]: at addChunk (internal/streams/readable.js:293:12) Oct 04 18:55:54 volumio volumio[867]: at readableAddChunk (internal/streams/readable.js:267:9) Oct 04 18:55:54 volumio volumio[867]: at Socket.Readable.push (internal/streams/readable.js:206:10) Oct 04 18:55:54 volumio volumio[867]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Oct 04 18:55:54 volumio volumio[867]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 18:55:55 volumio sudo[14910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-04 18:54 Oct 04 18:55:55 volumio sudo[14910]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"