May 30 13:18:01 musicbox2 volumio[3577]: info: Checking if install.sh is present
May 30 13:18:01 musicbox2 volumio[3577]: info: Executing install.sh
May 30 13:18:01 musicbox2 sudo[17970]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/pandora/install.sh
May 30 13:18:01 musicbox2 sudo[17970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 30 13:18:01 musicbox2 sudo[17970]: pam_unix(sudo:session): session closed for user root
May 30 13:18:01 musicbox2 volumio[3577]: info: Installing Pandora Dependencies
May 30 13:18:01 musicbox2 volumio[3577]: Plugin install end detected on script
May 30 13:18:01 musicbox2 volumio[3577]: info: Install script completed
May 30 13:18:01 musicbox2 volumio[3577]: info: Adding reference to registry
May 30 13:18:01 musicbox2 volumio[3577]: info: Done installing plugin.
May 30 13:18:01 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 30 13:18:01 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 30 13:18:01 musicbox2 volumio[3577]: info: Folder /tmp/plugins removed
May 30 13:18:01 musicbox2 volumio[3577]: info: Folder /tmp/downloaded_plugin.zip removed
May 30 13:18:01 musicbox2 volumio[3577]: info: Folder /data/temp removed
May 30 13:18:03 musicbox2 volumio[3577]: info: Enabling plugin pandora
May 30 13:18:03 musicbox2 volumio[3577]: info: Loading plugin "pandora"...
May 30 13:18:04 musicbox2 volumio[3577]: info: PLUGIN START: pandora
May 30 13:18:04 musicbox2 volumio[3577]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084557] CoreMusicLibrary::Adding element Pandora Radio
May 30 13:18:04 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 30 13:18:04 musicbox2 volumio[3577]: Cannot find translation for source YouTube Music
May 30 13:18:04 musicbox2 volumio[3577]: Cannot find translation for source Pandora Radio
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084560] ControllerPandora::initializeMQTT
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084560] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084561] ControllerPandora::initialSetup
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084563] ControllerPandora::PandoraHandler::init
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084563] ControllerPandora::PandoraHandler::loadErrorCodes
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084564] [Pandora] PandoraHandler::setMaxStationTracks: 16
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084564] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084565] ControllerPandora::flushPandora
May 30 13:18:04 musicbox2 volumio[3577]: info: CorePlayQueue::getQueue
May 30 13:18:04 musicbox2 volumio[3577]: info: CorePlayQueue::clearAddPlayQueue
May 30 13:18:04 musicbox2 volumio[3577]: info: CorePlayQueue::saveQueue
May 30 13:18:04 musicbox2 volumio[3577]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 30 13:18:04 musicbox2 volumio[3577]: error: WARNING: No clearAddPlayTracks method for service ytmusic
May 30 13:18:04 musicbox2 volumio[3577]: info: CoreCommandRouter::volumioPushQueue
May 30 13:18:04 musicbox2 volumio[3577]: info: [1748629084574] ControllerPandora::validateAndSetAccountOptions
May 30 13:18:04 musicbox2 volumio[3577]: error: [1748629084574] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
May 30 13:18:04 musicbox2 volumio[3577]: info: Done.
May 30 13:18:08 musicbox2 volumio[3577]: info: Enabling plugin pandora
May 30 13:18:08 musicbox2 volumio[3577]: info: Loading plugin "pandora"...
May 30 13:18:08 musicbox2 volumio[3577]: info: Applying required configuration parameters for plugin pandora
May 30 13:18:08 musicbox2 volumio[3577]: info: PLUGIN START: pandora
May 30 13:18:08 musicbox2 volumio[3577]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088824] CoreMusicLibrary::Adding element Pandora Radio
May 30 13:18:08 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 30 13:18:08 musicbox2 volumio[3577]: Cannot find translation for source YouTube Music
May 30 13:18:08 musicbox2 volumio[3577]: Cannot find translation for source Pandora Radio
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088826] ControllerPandora::initializeMQTT
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088826] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088826] ControllerPandora::initialSetup
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088827] ControllerPandora::PandoraHandler::init
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088827] ControllerPandora::PandoraHandler::loadErrorCodes
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088828] [Pandora] PandoraHandler::setMaxStationTracks: 16
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088828] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088828] ControllerPandora::flushPandora
May 30 13:18:08 musicbox2 volumio[3577]: info: CorePlayQueue::getQueue
May 30 13:18:08 musicbox2 volumio[3577]: info: CorePlayQueue::clearAddPlayQueue
May 30 13:18:08 musicbox2 volumio[3577]: info: CorePlayQueue::saveQueue
May 30 13:18:08 musicbox2 volumio[3577]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 30 13:18:08 musicbox2 volumio[3577]: error: WARNING: No clearAddPlayTracks method for service ytmusic
May 30 13:18:08 musicbox2 volumio[3577]: info: CoreCommandRouter::volumioPushQueue
May 30 13:18:08 musicbox2 volumio[3577]: info: [1748629088836] ControllerPandora::validateAndSetAccountOptions
May 30 13:18:08 musicbox2 volumio[3577]: error: [1748629088836] [Pandora] validateAndSetAccountOptions: Need email address and password. See plugin settings.
May 30 13:18:08 musicbox2 volumio[3577]: info: Done.
May 30 13:18:27 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 30 13:18:27 musicbox2 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
May 30 13:18:27 musicbox2 dbus-daemon[655]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.124' (uid=0 pid=18069 comm="timedatectl show --property=NTPSynchronized --valu")
May 30 13:18:27 musicbox2 systemd[1]: Starting systemd-timedated.service - Time & Date Service...
May 30 13:18:27 musicbox2 dbus-daemon[655]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 30 13:18:27 musicbox2 systemd[1]: Started systemd-timedated.service - Time & Date Service.
May 30 13:18:27 musicbox2 setdatetime-helper.sh[18068]: Time is already synchronized.
May 30 13:18:27 musicbox2 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
May 30 13:18:27 musicbox2 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
May 30 13:18:35 musicbox2 volumio[3577]: info: CoreCommandRouter::volumioGetState
May 30 13:18:35 musicbox2 volumio[3577]: info: CorePlayQueue::getTrack 13
May 30 13:18:37 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 30 13:18:37 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 30 13:18:40 musicbox2 volumio[3577]: info: CoreCommandRouter::getUIConfigOnPlugin
May 30 13:18:57 musicbox2 systemd[1]: systemd-timedated.service: Deactivated successfully.
May 30 13:19:30 musicbox2 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
May 30 13:19:30 musicbox2 dbus-daemon[655]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.126' (uid=0 pid=18290 comm="timedatectl show --property=NTPSynchronized --valu")
May 30 13:19:30 musicbox2 systemd[1]: Starting systemd-timedated.service - Time & Date Service...
May 30 13:19:30 musicbox2 dbus-daemon[655]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 30 13:19:30 musicbox2 systemd[1]: Started systemd-timedated.service - Time & Date Service.
May 30 13:19:30 musicbox2 setdatetime-helper.sh[18289]: Time is already synchronized.
May 30 13:19:30 musicbox2 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
May 30 13:19:30 musicbox2 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
May 30 13:19:36 musicbox2 volumio[3577]: info: CALLMETHOD: music_service pandora setAccountOptionsConf [object Object]
May 30 13:19:36 musicbox2 volumio[3577]: info: CoreCommandRouter::executeOnPlugin: pandora , setAccountOptionsConf
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176474] ControllerPandora::validateAndSetAccountOptions
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176474] ControllerPandora::PandoraHandler::setAccountOptions
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176475] ControllerPandora::flushPandora
May 30 13:19:36 musicbox2 volumio[3577]: info: CorePlayQueue::getQueue
May 30 13:19:36 musicbox2 volumio[3577]: info: CorePlayQueue::clearAddPlayQueue
May 30 13:19:36 musicbox2 volumio[3577]: info: CorePlayQueue::saveQueue
May 30 13:19:36 musicbox2 volumio[3577]: info: CoreCommandRouter::serviceClearAddPlayTracks
May 30 13:19:36 musicbox2 volumio[3577]: error: WARNING: No clearAddPlayTracks method for service ytmusic
May 30 13:19:36 musicbox2 volumio[3577]: info: CoreCommandRouter::volumioPushQueue
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176486] [Pandora] PreventAuthTimeout::init: Timer loaded
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176486] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176486] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval
May 30 13:19:36 musicbox2 volumio[3577]: info: [1748629176487] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations
May 30 13:19:36 musicbox2 volumio[3577]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 30 13:19:36 musicbox2 volumio[3577]: Error: error:0308010C:digital envelope routines::unsupported
May 30 13:19:36 musicbox2 volumio[3577]: at Decipheriv.createCipherBase (node:internal/crypto/cipher:121:19)
May 30 13:19:36 musicbox2 volumio[3577]: at Decipheriv.createCipherWithIV (node:internal/crypto/cipher:140:3)
May 30 13:19:36 musicbox2 volumio[3577]: at new Decipheriv (node:internal/crypto/cipher:289:3)
May 30 13:19:36 musicbox2 volumio[3577]: at Object.createDecipheriv (node:crypto:154:10)
May 30 13:19:36 musicbox2 volumio[3577]: at /data/plugins/music_service/pandora/node_modules/anesidora/encryption.js:30:29
May 30 13:19:36 musicbox2 volumio[3577]: at exports.decrypt (/data/plugins/music_service/pandora/node_modules/anesidora/encryption.js:45:16)
May 30 13:19:36 musicbox2 volumio[3577]: at decryptSyncTime (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:54:36)
May 30 13:19:36 musicbox2 volumio[3577]: at /data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:72:37
May 30 13:19:36 musicbox2 volumio[3577]: at Request._callback (/data/plugins/music_service/pandora/node_modules/anesidora/anesidora.js:46:24)
May 30 13:19:36 musicbox2 volumio[3577]: at self.callback (/data/plugins/music_service/pandora/node_modules/request/request.js:185:22)
May 30 13:19:36 musicbox2 volumio[3577]: at Request.emit (node:events:514:28)
May 30 13:19:36 musicbox2 volumio[3577]: at Request. (/data/plugins/music_service/pandora/node_modules/request/request.js:1154:10)
May 30 13:19:36 musicbox2 volumio[3577]: at Request.emit (node:events:514:28)
May 30 13:19:36 musicbox2 volumio[3577]: at IncomingMessage. (/data/plugins/music_service/pandora/node_modules/request/request.js:1076:12)
May 30 13:19:36 musicbox2 volumio[3577]: at Object.onceWrapper (node:events:628:28)
May 30 13:19:36 musicbox2 volumio[3577]: at IncomingMessage.emit (node:events:526:35) {
May 30 13:19:36 musicbox2 volumio[3577]: library: 'digital envelope routines',
May 30 13:19:36 musicbox2 volumio[3577]: reason: 'unsupported',
May 30 13:19:36 musicbox2 volumio[3577]: code: 'ERR_OSSL_EVP_UNSUPPORTED'
May 30 13:19:36 musicbox2 volumio[3577]: }
May 30 13:19:36 musicbox2 volumio[3577]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 30 13:19:37 musicbox2 sudo[18335]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-30 13:18'
May 30 13:19:37 musicbox2 sudo[18335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="1da895bfdbb6eb90d965df32a25a3568df7c84ed"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu May 29 13:12:59 UTC 2025"
VOLUMIO_VERSION="4.004"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="2df63d74196e499fa1e34fb765df1cca"