-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Thu 2025-05-22 22:56:04 EDT. --
May 22 22:55:12 volumio volumio-remote-updater[555]: [2025-05-22 22:55:12] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
May 22 22:55:13 volumio volumio[908]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm.
May 22 22:55:13 volumio volumio[908]: info: [ytmusic] InnertubeLoader: obtaining po_token by visitorData...
May 22 22:55:14 volumio volumio[908]: info: CoreCommandRouter::volumioPlay
May 22 22:55:14 volumio volumio[908]: info: CoreStateMachine::play index undefined
May 22 22:55:14 volumio volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined
May 22 22:55:14 volumio volumio[908]: info: CorePlayQueue::getTrack 0
May 22 22:55:14 volumio volumio[908]: info: CoreStateMachine::startPlaybackTimer
May 22 22:55:14 volumio volumio[908]: info: CorePlayQueue::getTrack 0
May 22 22:55:14 volumio volumio[908]: info: [mixcloud] clearAddPlayTrack: mixcloud/cloudcast@cloudcastId=Q2xvdWRjYXN0OjIxODMzODA1NDE%3D@owner=DJJohnnyLooch
May 22 22:55:16 volumio volumio[908]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
May 22 22:55:16 volumio volumio[908]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
May 22 22:55:16 volumio volumio[908]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11
May 22 22:55:17 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand stop
May 22 22:55:17 volumio volumio[908]: info: sendMpdCommand stop took 17 milliseconds
May 22 22:55:17 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand clear
May 22 22:55:17 volumio volumio[908]: info:
May 22 22:55:17 volumio volumio[908]: ---------------------------- MPD announces system playlist update
May 22 22:55:17 volumio volumio[908]: info: Ignoring MPD Status Update
May 22 22:55:17 volumio volumio[908]: info: sendMpdCommand clear took 37 milliseconds
May 22 22:55:17 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f-192K,.m4a.urlset/index.m3u8"
May 22 22:55:17 volumio volumio[908]: info:
May 22 22:55:17 volumio volumio[908]: ---------------------------- MPD announces system playlist update
May 22 22:55:17 volumio volumio[908]: info: Ignoring MPD Status Update
May 22 22:55:17 volumio volumio[908]: error: updateQueue error: null
May 22 22:55:17 volumio volumio[908]: info:
May 22 22:55:17 volumio volumio[908]: ---------------------------- MPD announces system playlist update
May 22 22:55:17 volumio volumio[908]: info: Ignoring MPD Status Update
May 22 22:55:17 volumio volumio[908]: info: ------------------------------ 151ms
May 22 22:55:17 volumio volumio[908]: info: sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f-192K,.m4a.urlset/index.m3u8" took 60 milliseconds
May 22 22:55:17 volumio volumio[908]: info: ------------------------------ 57ms
May 22 22:55:17 volumio volumio[908]: verbose: MPD COMMAND [object Object]
May 22 22:55:17 volumio volumio[908]: verbose: MPD COMMAND [object Object]
May 22 22:55:17 volumio volumio[908]: info:
May 22 22:55:17 volumio volumio[908]: ---------------------------- MPD announces system playlist update
May 22 22:55:17 volumio volumio[908]: info: Ignoring MPD Status Update
May 22 22:55:17 volumio volumio[908]: info:
May 22 22:55:17 volumio volumio[908]: ---------------------------- MPD announces system playlist update
May 22 22:55:17 volumio volumio[908]: info: Ignoring MPD Status Update
May 22 22:55:17 volumio volumio[908]: info: ------------------------------ 49ms
May 22 22:55:17 volumio volumio[908]: info: ------------------------------ 39ms
May 22 22:55:17 volumio volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd
May 22 22:55:17 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand play
May 22 22:55:17 volumio volumio[908]: info:
May 22 22:55:17 volumio volumio[908]: ---------------------------- MPD announces system playlist update
May 22 22:55:17 volumio volumio[908]: info: Ignoring MPD Status Update
May 22 22:55:17 volumio volumio[908]: info: ------------------------------ 31ms
May 22 22:55:17 volumio volumio[908]: info: sendMpdCommand play took 27 milliseconds
May 22 22:55:17 volumio volumio[908]: info: ------------------------------ 26ms
May 22 22:55:17 volumio volumio[908]: info: [ytmusic] InnertubeLoader: obtained po_token (expires in 43200 seconds)
May 22 22:55:17 volumio volumio[908]: info: [ytmusic] InnertubeLoader: re-create Innertube instance with po_token
May 22 22:55:17 volumio volumio[908]: info: [ytmusic] InnertubeLoader: creating Innertube instance with po_token...
May 22 22:55:17 volumio volumio-remote-updater[555]: [2025-05-22 22:55:17] [connect] Successful connection
May 22 22:55:17 volumio volumio-remote-updater[555]: [2025-05-22 22:55:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747968917 101
May 22 22:55:17 volumio volumio[908]: 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: 12
May 22 22:55:28 volumio volumio[908]: [YOUTUBEJS][Player]: Failed to extract signature decipher algorithm.
May 22 22:55:29 volumio volumio[908]: info: [ytmusic] InnertubeLoader: going to refresh po_token in 43100 seconds
May 22 22:55:29 volumio volumio[908]: info:
May 22 22:55:29 volumio volumio[908]: ---------------------------- MPD announces state update: player
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::getState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand status
May 22 22:55:29 volumio volumio[908]: info:
May 22 22:55:29 volumio volumio[908]: ---------------------------- MPD announces state update: player
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::getState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand status
May 22 22:55:29 volumio volumio[908]: info:
May 22 22:55:29 volumio volumio[908]: ---------------------------- MPD announces state update: player
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::getState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand status
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand clearerror
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand status took 40 milliseconds
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand clearerror
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand status took 38 milliseconds
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 22:55:29 volumio volumio[908]: info:
May 22 22:55:29 volumio volumio[908]: ---------------------------- MPD announces state update: player
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::getState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand status
May 22 22:55:29 volumio volumio[908]: verbose: New Socket.io Connection to 192.168.8.249:3000 from 192.168.8.203 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand clearerror
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand status took 77 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand clearerror took 56 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand clearerror took 54 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand playlistinfo took 43 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand playlistinfo took 41 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand status took 38 milliseconds
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseTrackInfo
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseTrackInfo
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseState
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::servicePushState
May 22 22:55:29 volumio volumio[908]: info: CorePlayQueue::getTrack 0
May 22 22:55:29 volumio volumio[908]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":13380,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Johnny Looch Show - Live from The Tent - 5/19/25","artist":"DJ Johnny Looch","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"}
May 22 22:55:29 volumio volumio[908]: verbose: CURRENT POSITION 0
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState stateService pause
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState currentStatus stop
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::volumioPushState
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::servicePushState
May 22 22:55:29 volumio volumio[908]: info: CorePlayQueue::getTrack 0
May 22 22:55:29 volumio volumio[908]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":13380,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Johnny Looch Show - Live from The Tent - 5/19/25","artist":"DJ Johnny Looch","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"}
May 22 22:55:29 volumio volumio[908]: verbose: CURRENT POSITION 0
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState stateService pause
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState currentStatus stop
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::volumioPushState
May 22 22:55:29 volumio volumio[908]: info: ------------------------------ 159ms
May 22 22:55:29 volumio volumio[908]: info: ------------------------------ 154ms
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppySpectrum ---peppyspectrum status
May 22 22:55:29 volumio volumio[908]: info: PeppySpectrum ---peppyspectrum status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:29 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:29 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand clearerror took 155 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand playlistinfo took 150 milliseconds
May 22 22:55:29 volumio volumio[908]: info: sendMpdCommand playlistinfo took 146 milliseconds
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseTrackInfo
May 22 22:55:29 volumio volumio[908]: verbose: ControllerMpd::parseTrackInfo
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::servicePushState
May 22 22:55:29 volumio volumio[908]: info: CorePlayQueue::getTrack 0
May 22 22:55:29 volumio volumio[908]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":13380,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Johnny Looch Show - Live from The Tent - 5/19/25","artist":"DJ Johnny Looch","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"}
May 22 22:55:29 volumio volumio[908]: verbose: CURRENT POSITION 0
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState stateService pause
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState currentStatus stop
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::volumioPushState
May 22 22:55:29 volumio volumio[908]: info: ControllerMpd::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::servicePushState
May 22 22:55:29 volumio volumio[908]: info: CorePlayQueue::getTrack 0
May 22 22:55:29 volumio volumio[908]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":13380,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Johnny Looch Show - Live from The Tent - 5/19/25","artist":"DJ Johnny Looch","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f,8/a/5/5/dc90-8ff9-4606-b7fb-d9909e327e8f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"}
May 22 22:55:29 volumio volumio[908]: verbose: CURRENT POSITION 0
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState stateService pause
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::syncState currentStatus stop
May 22 22:55:29 volumio volumio[908]: info: CoreStateMachine::pushState
May 22 22:55:29 volumio volumio[908]: info: CoreCommandRouter::volumioPushState
May 22 22:55:29 volumio volumio[908]: info: ------------------------------ 266ms
May 22 22:55:29 volumio volumio[908]: info: ------------------------------ 224ms
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppySpectrum ---peppyspectrum status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppySpectrum ---peppyspectrum status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:29 volumio volumio[908]: info: PeppyMeterBasic ---peppymeterbasic status undefined
May 22 22:55:40 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:40 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:40 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:40 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:40 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:48 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:49 volumio sudo[23170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 22 22:55:49 volumio sudo[23170]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 22 22:55:49 volumio sudo[23170]: pam_unix(sudo:session): session closed for user root
May 22 22:55:49 volumio sudo[23173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 22 22:55:49 volumio sudo[23173]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 22 22:55:50 volumio sudo[23173]: pam_unix(sudo:session): session closed for user root
May 22 22:55:50 volumio volumio[908]: verbose: New Socket.io Connection to 192.168.8.249 from 192.168.8.203 UA: Mozilla/5.0 (Linux; Android 15; Pixel 7 Build/BP1A.250505.005.B1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
May 22 22:55:50 volumio sudo[23176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 22 22:55:50 volumio sudo[23176]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 22 22:55:50 volumio sudo[23176]: pam_unix(sudo:session): session closed for user root
May 22 22:55:50 volumio sudo[23179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 22 22:55:50 volumio sudo[23179]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 22 22:55:50 volumio sudo[23179]: pam_unix(sudo:session): session closed for user root
May 22 22:55:50 volumio volumio[908]: verbose: New Socket.io Connection to 192.168.8.249 from 192.168.8.203 UA: Mozilla/5.0 (Linux; Android 15; Pixel 7 Build/BP1A.250505.005.B1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::volumioGetVisibleSources
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 22 22:55:50 volumio volumio[908]: info: Received Get System Info
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:50 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:50 volumio volumio[908]: info: Listing playlists
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 22 22:55:50 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 22 22:55:52 volumio volumio[908]: info: Received Get System Info
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:52 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 22 22:55:52 volumio volumio[908]: info: Received Get System Info
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:52 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:52 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:55 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:55:55 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:55:55 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:55:55 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:55:55 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:56 volumio volumio[908]: info: Retrieving Cloud Streaming UI
May 22 22:55:56 volumio volumio[908]: info: Getting Tidal Cloud Configuration
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:56 volumio volumio[908]: info: Getting Qobuz Cloud Configuration
May 22 22:55:56 volumio volumio[908]: info: Asking plugin for UI Config
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:56 volumio volumio[908]: info: Getting Spotify Cloud Configuration
May 22 22:55:56 volumio volumio[908]: info: Asking plugin for UI Config
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:56 volumio volumio[908]: info: Saving Spotify Acccount
May 22 22:55:56 volumio volumio[908]: info: Got Tidal Cloud Configuration
May 22 22:55:56 volumio volumio[908]: info: Got it
May 22 22:55:56 volumio volumio[908]: info: Got it
May 22 22:55:56 volumio volumio[908]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::getUIConfigOnPlugin
May 22 22:55:56 volumio volumio[908]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::volumioGetBrowseSources
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::volumioGetBrowseSources
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::volumioGetBrowseSources
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 22 22:55:56 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 22 22:56:00 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 22 22:56:00 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 22 22:56:00 volumio volumio[908]: info: Discovery: Getting this device information
May 22 22:56:00 volumio volumio[908]: info: CoreCommandRouter::volumioGetState
May 22 22:56:00 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 22 22:56:00 volumio volumio[908]: info: Disabling MyMusic plugin upnp
May 22 22:56:00 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 22 22:56:00 volumio sudo[23200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 22 22:56:00 volumio sudo[23200]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 22 22:56:00 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
May 22 22:56:00 volumio volumio[908]: error: Upnp client error: Error: This socket has been ended by the other party
May 22 22:56:00 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 22 22:56:03 volumio volumio[908]: info: Enabling MyMusic plugin upnp
May 22 22:56:03 volumio volumio[908]: info: Enabling plugin upnp
May 22 22:56:03 volumio volumio[908]: info: Loading plugin "upnp"...
May 22 22:56:03 volumio volumio[908]: info: [1747968963572] Starting Upmpd Daemon
May 22 22:56:03 volumio volumio[908]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 22 22:56:03 volumio volumio[908]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 22:56:03 volumio volumio[908]: Error: listen EADDRINUSE: address already in use :::6599
May 22 22:56:03 volumio volumio[908]: at Server.setupListenHandle [as _listen2] (net.js:1318:16)
May 22 22:56:03 volumio volumio[908]: at listenInCluster (net.js:1366:12)
May 22 22:56:03 volumio volumio[908]: at Server.listen (net.js:1452:7)
May 22 22:56:03 volumio volumio[908]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 22 22:56:03 volumio volumio[908]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 22 22:56:03 volumio volumio[908]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 22 22:56:03 volumio volumio[908]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 22 22:56:03 volumio volumio[908]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
May 22 22:56:03 volumio volumio[908]: code: 'EADDRINUSE',
May 22 22:56:03 volumio volumio[908]: errno: -98,
May 22 22:56:03 volumio volumio[908]: syscall: 'listen',
May 22 22:56:03 volumio volumio[908]: address: '::',
May 22 22:56:03 volumio volumio[908]: port: 6599
May 22 22:56:03 volumio volumio[908]: }
May 22 22:56:03 volumio volumio[908]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 22:56:04 volumio sudo[23212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 22:55
May 22 22:56:04 volumio sudo[23212]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"