-- Logs begin at Fri 2022-04-15 15:54:15 UTC, end at Wed 2024-05-01 14:31:40 UTC. --
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.190 E [ap:1694] AP Socket Error: Software caused connection abort (103)
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.191 E [ap:3953] Connection error: 112
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.192 I [ap:1752] Connecting to AP ap.spotify.com:443
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.262 I [ap:1226] Connected to AP: 104.199.240.237:443
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.443 E [ap:1694] AP Socket Error: Software caused connection abort (103)
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.444 E [ap:3953] Connection error: 112
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.444 I [ap:1752] Connecting to AP ap.spotify.com:80
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.523 I [ap:1226] Connected to AP: 104.199.240.237:80
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.759 E [ap:1694] AP Socket Error: Software caused connection abort (103)
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [SPTF] 14:30:00.760 E [ap:3953] Connection error: 112
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [WARN] Login failed: Cannot connect to Spotify
May 01 14:30:00 volumio-01 volumio[7660]: 2024-05-01 14:30:00 [ERR ] Could not get the playlist container.
May 01 14:30:00 volumio-01 systemd[1]: spop.service: Main process exited, code=killed, status=5/TRAP
May 01 14:30:00 volumio-01 systemd[1]: spop.service: Failed with result 'signal'.
May 01 14:30:05 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:30:05 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 17) (YouTube Music) Incoming message: 'noop'
May 01 14:30:05 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 17) (YouTube Music) Not handled: 'noop'
May 01 14:30:14 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:30:14 volumio-01 volumio[5513]: info: CURURI: music-library
May 01 14:30:14 volumio-01 volumio[5513]: error: Failed LSINFO: null
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 14:30:19 volumio-01 volumio[5513]: info: Retrieving Cloud Streaming UI
May 01 14:30:19 volumio-01 volumio[5513]: info: Getting Tidal Cloud Configuration
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 14:30:19 volumio-01 volumio[5513]: info: Getting Qobuz Cloud Configuration
May 01 14:30:19 volumio-01 volumio[5513]: info: Asking plugin for UI Config
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 14:30:19 volumio-01 volumio[5513]: info: Getting Spotify Cloud Configuration
May 01 14:30:19 volumio-01 volumio[5513]: info: Asking plugin for UI Config
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 14:30:19 volumio-01 volumio[5513]: info: Saving Spotify Acccount
May 01 14:30:19 volumio-01 volumio[5513]: info: Got Tidal Cloud Configuration
May 01 14:30:19 volumio-01 volumio[5513]: info: Got it
May 01 14:30:19 volumio-01 volumio[5513]: info: Got it
May 01 14:30:19 volumio-01 volumio[5513]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 14:30:19 volumio-01 volumio[5513]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetBrowseSources
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 01 14:30:19 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 01 14:30:20 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:30:20 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 18) (YouTube) Incoming message: 'noop'
May 01 14:30:20 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 18) (YouTube) Not handled: 'noop'
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand rescan
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand status
May 01 14:30:21 volumio-01 volumio[5513]: info:
May 01 14:30:21 volumio-01 volumio[5513]: ---------------------------- MPD announces state update: update
May 01 14:30:21 volumio-01 volumio[5513]: info: sendMpdCommand rescan took 8 milliseconds
May 01 14:30:21 volumio-01 volumio[5513]: info: ControllerMpd::getState
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand status
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand status
May 01 14:30:21 volumio-01 volumio[5513]: info:
May 01 14:30:21 volumio-01 volumio[5513]: ---------------------------- MPD announces state update: update
May 01 14:30:21 volumio-01 volumio[5513]: info: sendMpdCommand status took 25 milliseconds
May 01 14:30:21 volumio-01 volumio[5513]: info: ControllerMpd::getState
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand status
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::parseState
May 01 14:30:21 volumio-01 volumio[5513]: info: Command Router : Notfying DB Updatefalse
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::Close All Modals sent
May 01 14:30:21 volumio-01 volumio[5513]: info: sendMpdCommand status took 103 milliseconds
May 01 14:30:21 volumio-01 volumio[5513]: info: sendMpdCommand status took 85 milliseconds
May 01 14:30:21 volumio-01 volumio[5513]: info: sendMpdCommand status took 82 milliseconds
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::parseState
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::parseState
May 01 14:30:21 volumio-01 volumio[5513]: info: Command Router : Notfying DB Updatefalse
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::Close All Modals sent
May 01 14:30:21 volumio-01 volumio[5513]: verbose: ControllerMpd::parseState
May 01 14:30:21 volumio-01 volumio[5513]: info: ControllerMpd::pushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::servicePushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreStateMachine::pushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:21 volumio-01 volumio[5513]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 01 14:30:21 volumio-01 volumio[5513]: info: ControllerMpd::pushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::servicePushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreStateMachine::pushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:21 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPushState
May 01 14:30:21 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:21 volumio-01 volumio[5513]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
May 01 14:30:21 volumio-01 volumio[5513]: info: ------------------------------ 219ms
May 01 14:30:21 volumio-01 volumio[5513]: info: ------------------------------ 207ms
May 01 14:30:24 volumio-01 ntpd[5516]: Soliciting pool server 2001:470:1d:281::123
May 01 14:30:26 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 01 14:30:27 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 01 14:30:34 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:30:34 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 18) (YouTube Music) Incoming message: 'noop'
May 01 14:30:34 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 18) (YouTube Music) Not handled: 'noop'
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 14:30:35 volumio-01 volumio[5513]: info: Discovery: Getting this device information
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:30:35 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 14:30:35 volumio-01 volumio[5513]: info: Discovery: Getting this device information
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:30:35 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 14:30:35 volumio-01 volumio[5513]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.9 UA: unknown Total Clients: 3
May 01 14:30:35 volumio-01 volumio[5513]: verbose: New Socket.io Connection to 192.168.1.15 from 192.168.1.9 UA: unknown Total Clients: 4
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:30:35 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:30:35 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 01 14:30:35 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 01 14:30:37 volumio-01 sudo[7777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 01 14:30:37 volumio-01 sudo[7777]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 14:30:37 volumio-01 sudo[7777]: pam_unix(sudo:session): session closed for user root
May 01 14:30:37 volumio-01 sudo[7780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 14:30:37 volumio-01 sudo[7780]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 14:30:37 volumio-01 sudo[7780]: pam_unix(sudo:session): session closed for user root
May 01 14:30:37 volumio-01 volumio[5513]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.9 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5
May 01 14:30:37 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:30:37 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:37 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 01 14:30:37 volumio-01 volumio[5513]: info: Listing playlists
May 01 14:30:37 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 01 14:30:37 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 01 14:30:37 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 01 14:30:37 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 01 14:30:43 volumio-01 sudo[7793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 01 14:30:43 volumio-01 sudo[7793]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 14:30:43 volumio-01 sudo[7793]: pam_unix(sudo:session): session closed for user root
May 01 14:30:43 volumio-01 sudo[7796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 14:30:43 volumio-01 sudo[7796]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 14:30:43 volumio-01 sudo[7796]: pam_unix(sudo:session): session closed for user root
May 01 14:30:43 volumio-01 volumio[5513]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.9 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5
May 01 14:30:43 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:30:43 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:43 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 01 14:30:43 volumio-01 volumio[5513]: info: Listing playlists
May 01 14:30:43 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 01 14:30:43 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 01 14:30:43 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 01 14:30:43 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 01 14:30:46 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:30:46 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 19) (YouTube) Incoming message: 'noop'
May 01 14:30:46 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 19) (YouTube) Not handled: 'noop'
May 01 14:30:51 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetQueue
May 01 14:30:51 volumio-01 volumio[5513]: info: CoreStateMachine::getQueue
May 01 14:30:51 volumio-01 volumio[5513]: info: CorePlayQueue::getQueue
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPlay
May 01 14:30:53 volumio-01 volumio[5513]: verbose: UNSET VOLATILE
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::play index 3
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::stop
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 14:30:53 volumio-01 volumio[5513]: verbose: UNSET VOLATILE
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::stPlaybackTimer
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::updateTrackBlock
May 01 14:30:53 volumio-01 volumio[5513]: info: CorePlayQueue::getTrackBlock
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::pushState
May 01 14:30:53 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPushState
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::serviceStop
May 01 14:30:53 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 0
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreCommandRouter::serviceStop
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::setConsumeUpdateService mpd
May 01 14:30:53 volumio-01 volumio[5513]: info: ControllerMpd::stop
May 01 14:30:53 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand stop
May 01 14:30:53 volumio-01 volumio[5513]: info: sendMpdCommand stop took 18 milliseconds
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::play index undefined
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::setConsumeUpdateService undefined
May 01 14:30:53 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 3
May 01 14:30:53 volumio-01 volumio[5513]: info: CoreStateMachine::startPlaybackTimer
May 01 14:30:53 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 3
May 01 14:30:53 volumio-01 volumio[5513]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22NH%E1%BA%A0C%20AUDIOPHILE%20VOL.2%22%2C%22artist%22%3A%22Audiophile%20vietnam%22%2C%22album%22%3A%22%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FYpJDKuGjWxA%2Fhq720.jpg%3Fsqp%3D-oaymwEXCNUGEOADIAQqCwjVARCqCBh4INgESFo%26rs%3DAMzJL3k1ceucT2D93Hz0Tee9hNqTvHql1g%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22YpJDKuGjWxA%22%2C%22playlistId%22%3A%22PLUMiYXaqq0s7M6O7fwd84TzJo6aOdmZf0%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22index%22%3A3%2C%22playlistSetVideoId%22%3A%2252152B4946C2F73F%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_UGC%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22PLUMiYXaqq0s7M6O7fwd84TzJo6aOdmZf0%22%2C%22params%22%3A%22OAHyAQIIAQ%253D%253D%22%2C%22videoId%22%3A%22wITXKmMNClQ%22%7D%7D%7D%7D
May 01 14:30:53 volumio-01 volumio[5513]: InnertubeError: Something went wrong at PlaylistExpandableMessage!
May 01 14:30:53 volumio-01 volumio[5513]: This is a bug, please report it at https://github.com/patrickkfkan/Volumio-YouTube.js/issues
May 01 14:30:53 volumio-01 volumio[5513]: at Function._Parser_printError (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18226:16)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18059:70)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseArray (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18069:29)
May 01 14:30:53 volumio-01 volumio[5513]: at new PlaylistPanel (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:15522:36)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)
May 01 14:30:53 volumio-01 volumio[5513]: at new MusicQueue (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:15539:35)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)
May 01 14:30:53 volumio-01 volumio[5513]: at new Tab (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:16592:35)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parse (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18086:29)
May 01 14:30:53 volumio-01 volumio[5513]: at new TwoColumnBrowseResults (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:16943:32)
May 01 14:30:53 volumio-01 volumio[5513]: at new WatchNextTabbedResults (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:17264:5)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parse (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39)
May 01 14:30:53 volumio-01 volumio[5513]: at new Tabbed (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:16693:36)
May 01 14:30:53 volumio-01 volumio[5513]: at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24) {
May 01 14:30:53 volumio-01 volumio[5513]: info: {
May 01 14:30:53 volumio-01 volumio[5513]: stack: 'Error: Type mismatch, got PlaylistExpandableMessage but expected one of PlaylistPanelVideoWrapper, PlaylistPanelVideo, AutomixPreviewVideo\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18051:21)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseArray (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18069:29)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at new PlaylistPanel (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:15522:36)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at new MusicQueue (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:15539:35)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at new Tab (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:16592:35)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parse (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18086:29)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at new TwoColumnBrowseResults (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:16943:32)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at new WatchNextTabbedResults (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:17264:5)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parse (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at new Tabbed (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:16693:36)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parseItem (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18055:24)\n' +
May 01 14:30:53 volumio-01 volumio[5513]: ' at Function.parse (/data/plugins/music_service/ytmusic/node_modules/volumio-youtubei.js/bundle/node.cjs:18096:39)'
May 01 14:30:53 volumio-01 volumio[5513]: },
May 01 14:30:53 volumio-01 volumio[5513]: date: 2024-05-01T14:30:53.951Z,
May 01 14:30:53 volumio-01 volumio[5513]: version: '0.3.3'
May 01 14:30:53 volumio-01 volumio[5513]: }
May 01 14:30:54 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 3
May 01 14:30:54 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand stop
May 01 14:30:54 volumio-01 volumio[5513]: info: sendMpdCommand stop took 3 milliseconds
May 01 14:30:54 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand clear
May 01 14:30:54 volumio-01 volumio[5513]: info:
May 01 14:30:54 volumio-01 volumio[5513]: ---------------------------- MPD announces system playlist update
May 01 14:30:54 volumio-01 volumio[5513]: info: Ignoring MPD Status Update
May 01 14:30:54 volumio-01 volumio[5513]: info: sendMpdCommand clear took 4 milliseconds
May 01 14:30:54 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-8pxuuxa-i5ol6.googlevideo.com/videoplayback?expire=1714595453&ei=HVIyZqa6H9uy1d8Pnv6IyAo&ip=171.228.150.234&id=o-AIbL2J_6a_vzS1FGCiMH3DC4SYq7_Z8xDX6Ppc22N0YN&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=hq&mm=31%2C29&mn=sn-8pxuuxa-i5ol6%2Csn-8pxuuxa-i5o6d&ms=au%2Crdu&mv=m&mvi=4&pl=25&initcwndbps=1635000&bui=AWRWj2QKfYYfJdqBTBB_iNUrvnmT55Vl58jUv-ncuxAEqVZZV5r0qhA74-m3gliTYpgiUi6s0e8STfkK&spc=UWF9fwGja0hCGKUbJrgNtFo38yOihNtY0Yq0KJzBKKYyj1Y&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Z0lvws0yBnvtgPYYOi0DDQwQ&gir=yes&clen=59890679&dur=3296.221&lmt=1540097608390565&mt=1714572300&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5411222&n=kQU1ljCqKQZAmw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRAIgUZJlPjcaN-Sgr-R_fN2haRSzK6yLtczo35ZUbPWVQuYCICc7qz0iU7ynQ3k24kNIXDIH0sjmcNjgAueJ0bHu_uhg&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgV8lv3HnBly3eXCe--61Pme8j2DXejI5qZatvGeIl9w0CIFsj5zK2jYsZ3TeyGPC4aUNsX2zv2x89abgJ8QctmUfe&cver=1.20211213.00.00&t.YouTube"
May 01 14:30:54 volumio-01 volumio[5513]: error: updateQueue error: null
May 01 14:30:54 volumio-01 volumio[5513]: info:
May 01 14:30:54 volumio-01 volumio[5513]: ---------------------------- MPD announces system playlist update
May 01 14:30:54 volumio-01 volumio[5513]: info: Ignoring MPD Status Update
May 01 14:30:54 volumio-01 volumio[5513]: info: ------------------------------ 11ms
May 01 14:30:54 volumio-01 volumio[5513]: info: sendMpdCommand addid "https://rr4---sn-8pxuuxa-i5ol6.googlevideo.com/videoplayback?expire=1714595453&ei=HVIyZqa6H9uy1d8Pnv6IyAo&ip=171.228.150.234&id=o-AIbL2J_6a_vzS1FGCiMH3DC4SYq7_Z8xDX6Ppc22N0YN&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=hq&mm=31%2C29&mn=sn-8pxuuxa-i5ol6%2Csn-8pxuuxa-i5o6d&ms=au%2Crdu&mv=m&mvi=4&pl=25&initcwndbps=1635000&bui=AWRWj2QKfYYfJdqBTBB_iNUrvnmT55Vl58jUv-ncuxAEqVZZV5r0qhA74-m3gliTYpgiUi6s0e8STfkK&spc=UWF9fwGja0hCGKUbJrgNtFo38yOihNtY0Yq0KJzBKKYyj1Y&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Z0lvws0yBnvtgPYYOi0DDQwQ&gir=yes&clen=59890679&dur=3296.221&lmt=1540097608390565&mt=1714572300&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5411222&n=kQU1ljCqKQZAmw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRAIgUZJlPjcaN-Sgr-R_fN2haRSzK6yLtczo35ZUbPWVQuYCICc7qz0iU7ynQ3k24kNIXDIH0sjmcNjgAueJ0bHu_uhg&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgV8lv3HnBly3eXCe--61Pme8j2DXejI5qZatvGeIl9w0CIFsj5zK2jYsZ3TeyGPC4aUNsX2zv2x89abgJ8QctmUfe&cver=1.20211213.00.00&t.YouTube" took 8 milliseconds
May 01 14:30:54 volumio-01 volumio[5513]: verbose: MPD COMMAND [object Object]
May 01 14:30:54 volumio-01 volumio[5513]: verbose: MPD COMMAND [object Object]
May 01 14:30:54 volumio-01 volumio[5513]: info:
May 01 14:30:54 volumio-01 volumio[5513]: ---------------------------- MPD announces system playlist update
May 01 14:30:54 volumio-01 volumio[5513]: info: Ignoring MPD Status Update
May 01 14:30:54 volumio-01 volumio[5513]: info: ------------------------------ 17ms
May 01 14:30:54 volumio-01 volumio[5513]: info: CoreStateMachine::setConsumeUpdateService mpd
May 01 14:30:54 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand play
May 01 14:30:54 volumio-01 volumio[5513]: info: ------------------------------ 13ms
May 01 14:30:54 volumio-01 volumio[5513]: info: sendMpdCommand play took 6 milliseconds
May 01 14:30:58 volumio-01 volumio[5513]: info:
May 01 14:30:58 volumio-01 volumio[5513]: ---------------------------- MPD announces state update: player
May 01 14:30:58 volumio-01 volumio[5513]: info: ControllerMpd::getState
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand status
May 01 14:30:58 volumio-01 volumio[5513]: info:
May 01 14:30:58 volumio-01 volumio[5513]: ---------------------------- MPD announces state update: player
May 01 14:30:58 volumio-01 volumio[5513]: info: sendMpdCommand status took 10 milliseconds
May 01 14:30:58 volumio-01 volumio[5513]: info: ControllerMpd::getState
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand status
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::parseState
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 01 14:30:58 volumio-01 volumio[5513]: info: sendMpdCommand status took 6 milliseconds
May 01 14:30:58 volumio-01 volumio[5513]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::parseState
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::parseTrackInfo
May 01 14:30:58 volumio-01 volumio[5513]: info: ControllerMpd::pushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::servicePushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 3
May 01 14:30:58 volumio-01 volumio[5513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"NHẠC AUDIOPHILE VOL.2","artist":"Audiophile vietnam","album":null,"uri":"https://rr4---sn-8pxuuxa-i5ol6.googlevideo.com/videoplayback?expire=1714595453&ei=HVIyZqa6H9uy1d8Pnv6IyAo&ip=171.228.150.234&id=o-AIbL2J_6a_vzS1FGCiMH3DC4SYq7_Z8xDX6Ppc22N0YN&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=hq&mm=31%2C29&mn=sn-8pxuuxa-i5ol6%2Csn-8pxuuxa-i5o6d&ms=au%2Crdu&mv=m&mvi=4&pl=25&initcwndbps=1635000&bui=AWRWj2QKfYYfJdqBTBB_iNUrvnmT55Vl58jUv-ncuxAEqVZZV5r0qhA74-m3gliTYpgiUi6s0e8STfkK&spc=UWF9fwGja0hCGKUbJrgNtFo38yOihNtY0Yq0KJzBKKYyj1Y&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Z0lvws0yBnvtgPYYOi0DDQwQ&gir=yes&clen=59890679&dur=3296.221&lmt=1540097608390565&mt=1714572300&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5411222&n=kQU1ljCqKQZAmw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRAIgUZJlPjcaN-Sgr-R_fN2haRSzK6yLtczo35ZUbPWVQuYCICc7qz0iU7ynQ3k24kNIXDIH0sjmcNjgAueJ0bHu_uhg&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgV8lv3HnBly3eXCe--61Pme8j2DXejI5qZatvGeIl9w0CIFsj5zK2jYsZ3TeyGPC4aUNsX2zv2x89abgJ8QctmUfe&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 01 14:30:58 volumio-01 volumio[5513]: verbose: CURRENT POSITION 3
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::syncState stateService play
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::syncState currentStatus stop
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::pushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPushState
May 01 14:30:58 volumio-01 volumio[5513]: info: ------------------------------ 66ms
May 01 14:30:58 volumio-01 volumio[5513]: info: sendMpdCommand playlistinfo took 43 milliseconds
May 01 14:30:58 volumio-01 volumio[5513]: verbose: ControllerMpd::parseTrackInfo
May 01 14:30:58 volumio-01 volumio[5513]: info: ControllerMpd::pushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::servicePushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CorePlayQueue::getTrack 3
May 01 14:30:58 volumio-01 volumio[5513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3296,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"NHẠC AUDIOPHILE VOL.2","artist":"Audiophile vietnam","album":null,"uri":"https://rr4---sn-8pxuuxa-i5ol6.googlevideo.com/videoplayback?expire=1714595453&ei=HVIyZqa6H9uy1d8Pnv6IyAo&ip=171.228.150.234&id=o-AIbL2J_6a_vzS1FGCiMH3DC4SYq7_Z8xDX6Ppc22N0YN&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=hq&mm=31%2C29&mn=sn-8pxuuxa-i5ol6%2Csn-8pxuuxa-i5o6d&ms=au%2Crdu&mv=m&mvi=4&pl=25&initcwndbps=1635000&bui=AWRWj2QKfYYfJdqBTBB_iNUrvnmT55Vl58jUv-ncuxAEqVZZV5r0qhA74-m3gliTYpgiUi6s0e8STfkK&spc=UWF9fwGja0hCGKUbJrgNtFo38yOihNtY0Yq0KJzBKKYyj1Y&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=Z0lvws0yBnvtgPYYOi0DDQwQ&gir=yes&clen=59890679&dur=3296.221&lmt=1540097608390565&mt=1714572300&fvip=5&keepalive=yes&c=WEB_REMIX&sefc=1&txp=5411222&n=kQU1ljCqKQZAmw&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRAIgUZJlPjcaN-Sgr-R_fN2haRSzK6yLtczo35ZUbPWVQuYCICc7qz0iU7ynQ3k24kNIXDIH0sjmcNjgAueJ0bHu_uhg&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgV8lv3HnBly3eXCe--61Pme8j2DXejI5qZatvGeIl9w0CIFsj5zK2jYsZ3TeyGPC4aUNsX2zv2x89abgJ8QctmUfe&cver=1.20211213.00.00&t.YouTube","trackType":"YouTube"}
May 01 14:30:58 volumio-01 volumio[5513]: verbose: CURRENT POSITION 3
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::syncState stateService play
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::syncState currentStatus play
May 01 14:30:58 volumio-01 volumio[5513]: info: Received an update from plugin. extracting info from payload
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::pushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreStateMachine::pushState
May 01 14:30:58 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioPushState
May 01 14:30:58 volumio-01 volumio[5513]: info: ------------------------------ 96ms
May 01 14:30:58 volumio-01 volumio[5513]: verbose: [ytcr] MPDSubsystemEventEmitter invoking 1 SubsystemEventListener callbacks for: player
May 01 14:30:59 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:30:59 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 19) (YouTube Music) Incoming message: 'noop'
May 01 14:30:59 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 19) (YouTube Music) Not handled: 'noop'
May 01 14:31:02 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 01 14:31:03 volumio-01 volumio[5513]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 01 14:31:03 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 01 14:31:03 volumio-01 volumio[5513]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio
May 01 14:31:03 volumio-01 volumio[5513]: info: Received Get System Version
May 01 14:31:03 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 01 14:31:03 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetVisibleSources
May 01 14:31:03 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 14:31:06 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:31:06 volumio-01 volumio[5513]: info: CURURI: music-library
May 01 14:31:07 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:31:07 volumio-01 volumio[5513]: info: CURURI: music-library/NAS
May 01 14:31:07 volumio-01 volumio[5513]: error: Failed LSINFO: null
May 01 14:31:09 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:31:09 volumio-01 volumio[5513]: info: CURURI: music-library/INTERNAL
May 01 14:31:10 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:31:10 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 20) (YouTube) Incoming message: 'noop'
May 01 14:31:10 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 20) (YouTube) Not handled: 'noop'
May 01 14:31:10 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:31:10 volumio-01 volumio[5513]: info: CURURI: music-library/INTERNAL/NowPlayingPlugin
May 01 14:31:18 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:31:18 volumio-01 volumio[5513]: info: CURURI: music-library/USB
May 01 14:31:20 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 14:31:20 volumio-01 volumio[5513]: info: CURURI: music-library/USB/HUY_HOANG
May 01 14:31:20 volumio-01 volumio[5513]: error: Failed LSINFO: null
May 01 14:31:29 volumio-01 volumio[5513]: verbose: -----------------------------------
May 01 14:31:29 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 20) (YouTube Music) Incoming message: 'noop'
May 01 14:31:29 volumio-01 volumio[5513]: verbose: [yt-cast-receiver] (AID: 20) (YouTube Music) Not handled: 'noop'
May 01 14:31:30 volumio-01 ntpd[5516]: Soliciting pool server 2a02:2a50:6::123
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 14:31:32 volumio-01 volumio[5513]: info: Discovery: Getting this device information
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 01 14:31:32 volumio-01 volumio[5513]: info: Discovery: Getting this device information
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::volumioGetState
May 01 14:31:32 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 01 14:31:34 volumio-01 volumio[5513]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 01 14:31:39 volumio-01 volumio[5513]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
May 01 14:31:39 volumio-01 volumio[5513]: info: PLUGIN onReboot : networkfs
May 01 14:31:39 volumio-01 volumio[5513]: info: PLUGIN onReboot : audiophonicsonoff
May 01 14:31:39 volumio-01 volumio[5513]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 14:31:39 volumio-01 volumio[5513]: TypeError: Cannot read property 'writeSync' of undefined
May 01 14:31:39 volumio-01 volumio[5513]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
May 01 14:31:39 volumio-01 volumio[5513]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
May 01 14:31:39 volumio-01 volumio[5513]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
May 01 14:31:39 volumio-01 volumio[5513]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
May 01 14:31:39 volumio-01 volumio[5513]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
May 01 14:31:39 volumio-01 volumio[5513]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
May 01 14:31:39 volumio-01 volumio[5513]: at CoreCommandRouter.reboot (/volumio/app/index.js:1292:22)
May 01 14:31:39 volumio-01 volumio[5513]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:772:33)
May 01 14:31:39 volumio-01 volumio[5513]: at Socket.emit (events.js:400:28)
May 01 14:31:39 volumio-01 volumio[5513]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 01 14:31:39 volumio-01 volumio[5513]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
May 01 14:31:39 volumio-01 volumio[5513]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 14:31:40 volumio-01 sudo[7882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 14:30
May 01 14:31:40 volumio-01 sudo[7882]: 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="613d705c083fd29de3027cf6e63a923a6020da8e"
VOLUMIO_FE_VERSION="575f38b17bfc836dbd47f560a440d36ecd98d5af"
VOLUMIO_FE3_VERSION="af818e7eb038d49989134ddd7bf2b2ffaa8cf083"
VOLUMIO_BE_VERSION="5936439c04ed803864b9ef314729c659b841752e"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 29 Jan 2022 12:36:00 AM CET"
VOLUMIO_VERSION="3.212"
VOLUMIO_HARDWARE="kvim1"
VOLUMIO_DEVICENAME="Khadas VIM1"
VOLUMIO_HASH="a41712c8cd708e7cae9978278a240084"