-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-07-09 15:51:55 CEST. --
Jul 09 15:50:03 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:03+02:00" level=trace msg="sent dealer ping"
Jul 09 15:50:03 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:03+02:00" level=trace msg="received dealer pong"
Jul 09 15:50:05 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:05+02:00" level=debug msg="fetched chunk 13/19, size: 524288" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:50:08 icf-entertainment volumio[948]: info: Move to category
Jul 09 15:50:19 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:19+02:00" level=debug msg="fetched chunk 14/19, size: 524288" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:50:28 icf-entertainment volumio-remote-updater[604]: [2025-07-09 13:50:28] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Jul 09 15:50:33 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:33+02:00" level=debug msg="fetched chunk 15/19, size: 524288" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:50:33 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:33+02:00" level=trace msg="sent dealer ping"
Jul 09 15:50:33 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:33+02:00" level=trace msg="received dealer pong"
Jul 09 15:50:33 icf-entertainment volumio-remote-updater[604]: [2025-07-09 13:50:33] [connect] Successful connection
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Checking if install.sh is present
Jul 09 15:50:46 icf-entertainment volumio-remote-updater[604]: [2025-07-09 13:50:46] [connect] Successful connection
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Executing install.sh
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 3
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 7
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 8
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Jul 09 15:50:46 icf-entertainment volumio-remote-updater[604]: [2025-07-09 13:50:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752069046 101
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 11
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 12
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 13
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 14
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 15
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 16
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 17
Jul 09 15:50:46 icf-entertainment sudo[8807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/youtube2/install.sh
Jul 09 15:50:46 icf-entertainment sudo[8807]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 09 15:50:46 icf-entertainment sudo[8807]: pam_unix(sudo:session): session closed for user root
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 18
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 19
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 20
Jul 09 15:50:46 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 21
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Install script completed
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Adding reference to registry
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Done installing plugin.
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Folder /tmp/plugins removed
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Received Get System Info
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Discovery: Getting this device information
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Received Get System Info
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Discovery: Getting this device information
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Listing playlists
Jul 09 15:50:46 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:46 icf-entertainment volumio[948]: info: YouTube2 plugin installed
Jul 09 15:50:46 icf-entertainment volumio[948]: Plugin install end detected on script
Jul 09 15:50:46 icf-entertainment volumio[948]: info: Folder /data/temp removed
Jul 09 15:50:47 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 09 15:50:47 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:47 icf-entertainment volumio[948]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22
Jul 09 15:50:47 icf-entertainment volumio[948]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23
Jul 09 15:50:47 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:47 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:47 icf-entertainment volumio[948]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Jul 09 15:50:47 icf-entertainment go-librespot[2503]: time="2025-07-09T15:50:47+02:00" level=debug msg="fetched chunk 16/19, size: 524288" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:50:47 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:47 icf-entertainment volumio[948]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24
Jul 09 15:50:48 icf-entertainment volumio[948]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:48 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 26
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 15:50:48 icf-entertainment volumio[948]: info: Received Get System Info
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 15:50:48 icf-entertainment volumio[948]: info: Discovery: Getting this device information
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:50:48 icf-entertainment volumio[948]: info: Listing playlists
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:48 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 09 15:50:49 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:49 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:50 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:50 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:51 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:51 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:52 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:52 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:53 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:53 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:54 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:54 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:55 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:55 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:50:56 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jul 09 15:51:02 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:02+02:00" level=debug msg="fetched chunk 17/19, size: 524288" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:51:03 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:03+02:00" level=trace msg="received accesspoint ping"
Jul 09 15:51:03 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:03+02:00" level=trace msg="received accesspoint pong ack"
Jul 09 15:51:03 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:03+02:00" level=trace msg="sent dealer ping"
Jul 09 15:51:03 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:03+02:00" level=trace msg="received dealer pong"
Jul 09 15:51:08 icf-entertainment volumio[948]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf
Jul 09 15:51:10 icf-entertainment volumio[948]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytmusic/volumio/buster/armhf
Jul 09 15:51:10 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYouTube Music
Jul 09 15:51:10 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 15:51:10 icf-entertainment volumio[948]: Cannot find translation for source Spotify
Jul 09 15:51:16 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:16+02:00" level=debug msg="fetched chunk 18/19, size: 524288" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:51:29 icf-entertainment volumio[948]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 09 15:51:30 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:30+02:00" level=debug msg="fetched chunk 19/19, size: 335016" uri="spotify:track:4bNKvePgcSeo9eQM2yIbVE"
Jul 09 15:51:33 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:33+02:00" level=trace msg="sent dealer ping"
Jul 09 15:51:33 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:33+02:00" level=trace msg="received dealer pong"
Jul 09 15:51:41 icf-entertainment volumio-remote-updater[604]: [2025-07-09 13:51:41] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Jul 09 15:51:44 icf-entertainment volumio[948]: (node:948) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'logger' of null
Jul 09 15:51:44 icf-entertainment volumio[948]: at YTMusicContext.getLogger (/data/plugins/music_service/ytmusic/dist/lib/YTMusicContext.js:65:80)
Jul 09 15:51:44 icf-entertainment volumio[948]: at /data/plugins/music_service/ytmusic/dist/index.js:150:38
Jul 09 15:51:44 icf-entertainment volumio[948]: at runMicrotasks ()
Jul 09 15:51:44 icf-entertainment volumio[948]: at processTicksAndRejections (internal/process/task_queues.js:93:5)
Jul 09 15:51:44 icf-entertainment volumio[948]: (Use `node --trace-warnings ...` to show where the warning was created)
Jul 09 15:51:44 icf-entertainment volumio[948]: (node:948) 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)
Jul 09 15:51:44 icf-entertainment volumio[948]: (node:948) [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.
Jul 09 15:51:44 icf-entertainment volumio[948]: info: Check plugin dependencies
Jul 09 15:51:46 icf-entertainment volumio-remote-updater[604]: [2025-07-09 13:51:46] [connect] Successful connection
Jul 09 15:51:52 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:52+02:00" level=debug msg="prefetching next track" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:52 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:52+02:00" level=debug msg="selected format OGG_VORBIS_320 (6361a9931620a7524ddf8d5088b6a9d7af6c4bbb)" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:52 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:52+02:00" level=debug msg="requested aes key for file 6361a9931620a7524ddf8d5088b6a9d7af6c4bbb, gid: 7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:53 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:53+02:00" level=debug msg="fetched first chunk of 21, total size is 10960764 bytes" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:53 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:53+02:00" level=debug msg="fetched chunk 1/20, size: 524288" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:53 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:53+02:00" level=debug msg="fetched chunk 3/20, size: 524288" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:53 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:53+02:00" level=debug msg="fetched chunk 2/20, size: 524288" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:54 icf-entertainment go-librespot[2503]: time="2025-07-09T15:51:54+02:00" level=info msg="prefetched track \"Slide\" (duration: 292200ms)" uri="spotify:track:7jdQScXw0osMbGoxyS4ibn"
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 09 15:51:54 icf-entertainment volumio[948]: info: Rename folder
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jul 09 15:51:54 icf-entertainment volumio[948]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 7
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 9
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 10
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Jul 09 15:51:54 icf-entertainment volumio[948]: info: Move to category
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 12
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 13
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 14
Jul 09 15:51:54 icf-entertainment volumio[948]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.133 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Edg/138.0.0.0 Engine version: 3 Transport: polling Total Clients: 15
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:51:54 icf-entertainment volumio[948]: info: Received Get System Info
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 15:51:54 icf-entertainment volumio[948]: info: Discovery: Getting this device information
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 15:51:54 icf-entertainment volumio[948]: info: CoreCommandRouter::volumioGetState
Jul 09 15:51:54 icf-entertainment volumio[948]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 15:51:54 icf-entertainment volumio[948]: TypeError: Cannot read property 'plugin_type' of undefined
Jul 09 15:51:54 icf-entertainment volumio[948]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1644:56)
Jul 09 15:51:54 icf-entertainment volumio[948]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1540:29)
Jul 09 15:51:54 icf-entertainment volumio[948]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1342:45)
Jul 09 15:51:54 icf-entertainment volumio[948]: at Socket.emit (events.js:315:20)
Jul 09 15:51:54 icf-entertainment volumio[948]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jul 09 15:51:54 icf-entertainment volumio[948]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 09 15:51:54 icf-entertainment volumio[948]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 15:51:55 icf-entertainment sudo[9025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 15:50
Jul 09 15:51:55 icf-entertainment sudo[9025]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"