-- Logs begin at Sat 2024-04-20 00:19:41 UTC, end at Sat 2024-04-20 00:39:02 UTC. -- Apr 20 00:38:00 volumio volumio[2591]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 20 00:38:00 volumio volumio[2591]: info: MYVOLUMIO: Adding device Apr 20 00:38:00 volumio volumio[2591]: info: MYVOLUMIO: Evaluating Server Apr 20 00:38:00 volumio squeezeboxserver[2733]: [24-04-20 00:38:00.3650] main::main (205) Starting Logitech Media Server scanner (v7.9.1, 1522157629, Fri Mar 30 12:27:11 CEST 2018) perl 5.020002 Apr 20 00:38:00 volumio squeezeboxserver[2733]: [24-04-20 00:38:00.6689] Slim::Schema::forceCommit (2149) Warning: Trying to commit transactions before DB is initialized! Apr 20 00:38:01 volumio volumio[2591]: info: Cannot mount NAS share at system boot, trial number 3 ,retrying in 5 seconds Apr 20 00:38:01 volumio volumio[2591]: info: MyVolumio status changed Apr 20 00:38:01 volumio volumio[2591]: info: Streaming services startup Apr 20 00:38:01 volumio volumio[2591]: info: Re-Starting Streaming Daemon Apr 20 00:38:01 volumio volumio[2591]: info: Removing browser output: myVolumio user plan is not superstar Apr 20 00:38:01 volumio volumio[2591]: info: Removing audio output: Apr 20 00:38:01 volumio volumio[2591]: info: Stoppping Tunnel 1 Apr 20 00:38:01 volumio sudo[2888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 20 00:38:01 volumio sudo[2888]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 20 00:38:01 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Apr 20 00:38:01 volumio sudo[2888]: pam_unix(sudo:session): session closed for user root Apr 20 00:38:01 volumio volumio-remote-updater[586]: [2024-04-20 00:38:01] [connect] Successful connection Apr 20 00:38:03 volumio volumio[2591]: info: Setting Geolocation for MyVolumio to as1 Apr 20 00:38:03 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:03 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:03 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:03 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:03 volumio volumio-streaming-daemon[2861]: Restarting daemon Apr 20 00:38:03 volumio volumio-streaming-daemon[2861]: Environment: production Apr 20 00:38:03 volumio volumio[2591]: info: Remote SSH Stopped Apr 20 00:38:03 volumio volumio-remote-updater[586]: [2024-04-20 00:38:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1713573481 101 Apr 20 00:38:04 volumio volumio-streaming-daemon[2861]: Environment: production Apr 20 00:38:04 volumio volumio-streaming-daemon[2861]: Environment: production Apr 20 00:38:04 volumio volumio[2591]: info: Updating MyVolumio device info Apr 20 00:38:04 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:04 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:04 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:05 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:06 volumio volumio[2591]: info: Cannot mount NAS share at system boot, trial number 4 ,retrying in 5 seconds Apr 20 00:38:09 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:11 volumio volumio[2591]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 20 00:38:11 volumio volumio[2591]: info: Fetching Streaming Services browse cache Apr 20 00:38:11 volumio volumio[2591]: info: Fetching Streaming Services browse cache Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.1240] Slim::Music::Import::runImporter (511) Starting Slim::Media::MediaFolderScan scan Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.1245] Slim::Music::Import::endImporter (643) Completed Slim::Media::MediaFolderScan Scan in 0 seconds. Apr 20 00:38:13 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.4934] Slim::Music::Import::runImporter (511) Starting Slim::Plugin::FullTextSearch::Plugin scan Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.4948] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (396) Starting fulltext index build Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.4951] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (400) Initialize fulltext table Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.4977] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (406) Create fulltext index for tracks Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.6343] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (416) Create fulltext index for albums Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.6722] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (425) Create fulltext index for contributors Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.7095] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (435) Create fulltext index for playlists Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.7473] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (470) Optimize fulltext index Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.8618] Slim::Plugin::FullTextSearch::Plugin::_rebuildIndex (485) Fulltext index build done! Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.8622] Slim::Music::Import::endImporter (643) Completed Slim::Plugin::FullTextSearch::Plugin Scan in 0 seconds. Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.8638] Slim::Music::Artwork::precacheAllArtwork (619) Starting precacheArtwork for 0 albums Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.8641] Slim::Music::Import::endImporter (643) Completed precacheArtwork Scan in 0 seconds. Apr 20 00:38:13 volumio squeezeboxserver[2733]: [24-04-20 00:38:13.8979] Slim::Music::Import::runScanPostProcessing (435) Starting Database optimization. Apr 20 00:38:16 volumio squeezeboxserver[2733]: [24-04-20 00:38:16.4744] Slim::Music::Import::endImporter (643) Completed dbOptimize Scan in 2 seconds. Apr 20 00:38:17 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:20 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 20 00:38:20 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 00:38:21 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:25 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 20 00:38:26 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 20 00:38:26 volumio volumio[2591]: info: CURURI: playlists Apr 20 00:38:26 volumio volumio[2591]: info: Listing playlists Apr 20 00:38:28 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 20 00:38:28 volumio volumio[2591]: info: CURURI: music-library Apr 20 00:38:28 volumio volumio[2591]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined Apr 20 00:39:02 volumio volumio[2591]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 20 00:39:02 volumio volumio[2591]: info: CURURI: albums:// Apr 20 00:39:02 volumio volumio[2591]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 00:39:02 volumio volumio[2591]: TypeError: Cannot read property 'sendCommand' of undefined Apr 20 00:39:02 volumio volumio[2591]: at /volumio/app/plugins/music_service/mpd/index.js:2938:22 Apr 20 00:39:02 volumio volumio[2591]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Apr 20 00:39:02 volumio volumio[2591]: at process._tickCallback (internal/process/next_tick.js:180:9) Apr 20 00:39:02 volumio volumio[2591]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 00:39:02 volumio sudo[2935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-20 00:38 Apr 20 00:39:02 volumio sudo[2935]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"