Menu

Music collection does not update

simenon s
2017-02-09
2017-02-09
  • simenon s

    simenon s - 2017-02-09

    Hi,
    I have encountered the following problems with rompr.
    When I add audio files to the mpd folder and press 'Update Music Collection Now' in Rompr it says updating music collection... However, this message won't disappear, even after hours. I can only reload the page and music collection is visible.
    Now the strange thing is, that the newly added files to mpd (in: /mnt/music/FLAC) can be found with 'Search for' but they don't appear in the music collection list with the other artists.

    what can I do? br

     
  • Fat German Productions

    Thanks for the good description.
    It sounds like MPD is scanning the files but rompr is not noticing that MPD has scanned them.
    I need more information if I'm going to look into it - especially a debug log

    First, go to

    rompr/?setup
    

    Scroll to the bottom and set Debug Logging to Level 8. Do NOT set a Custom Log File. Click OK.

    Now update the collection in rompr and leave it running. After a few minutes (10 should be enough) send me the contents of your web server's error log.

    Also, I need to see what mpd thinks is happening:

    telnet your.mpd.ip.address:your-mpd-port
    

    When you get a prompt type

    status
    

    and send me the output.

    Hopefully this will help get to the bottom of it.

     
  • Anonymous

    Anonymous - 2017-02-09

    Hello
    Thanks for your quick response! I hope this will help

    /var/log/nginx/error_log
    
    2017/02/09 15:52:55 [error] 25281#25281: *759 FastCGI sent in stderr: "PHP message: INIT                : Probing Player Type....
    PHP message: INIT                :     ....tagtypes test says we're running MPD
    PHP message: SQL_CONNECT         : Connected to MySQL
    PHP message: MYSQL_CONNECT       :   Tracktable OK
    PHP message: MYSQL_CONNECT       :   Albumtable OK
    PHP message: MYSQL_CONNECT       :   Artisttable OK
    PHP message: MYSQL_CONNECT       :   Ratingtable OK
    PHP message: MYSQL_CONNECT       :   Tagtable OK
    PHP message: MYSQL_CONNECT       :   TagListtable OK
    PHP message: MYSQL_CONNECT       :   Playcounttable OK
    PHP message: MYSQL_CONNECT       :   Trackimagetable OK
    PHP message: STARTED UP          : =================****==================
    PHP message: INIT                : Including Skin Requirement css/jquery.mCustomScrollbar.css
    PHP message: INIT                : Including Skin Requirement css/tipTip.css" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/index.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/?setup"
    2017/02/09 15:52:55 [error] 25281#25281: *759 FastCGI sent in stderr: "PHP message: MYSQL               : Collection version is correct
    PHP message: INIT                : Server Address is 192.168.55.1
    PHP message: INIT                : Remote Address is 192.168.55.206
    PHP message: INIT                : Prefs for mpd host is 192.168.55.1
    PHP message: INIT                : Displaying Player IP as: 192.168.55.1
    PHP message: LAYOUT              : Including skins/desktop/skinvars.php
    PHP message: INIT                : Including Browser Helper browser/helpers/dbqueue.js
    PHP message: INIT                : Incl" while reading upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/index.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/?setup"
    2017/02/09 15:52:55 [error] 25281#25281: *759 FastCGI sent in stderr: "uding Browser Helper browser/helpers/discogs.js
    PHP message: INIT                : Including Browser Helper browser/helpers/musicbrainz.js
    PHP message: INIT                : Including Browser Helper browser/helpers/soundcloud.js
    PHP message: INIT                : Including Browser Helper browser/helpers/spotify.js
    PHP message: INIT                : Including Browser Helper browser/helpers/wikipedia.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/01_info_file.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/02_info_lastfm.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/03_info_wikipedia.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/04_info_musicbrainz.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/05_info_discogs.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/06_info_lyrics.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/07_info_soundcloud.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/08_info_spotify.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/09_info_videos.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/info_ratings.js
    PHP message: INIT                : Including Smart Radio Plugin radios/00_builtins.js
    PHP message: INIT                : Including Plugin plugins/alarmclock.js
    PHP message: INIT                : Including Plugin plugins/dynamic.js
    PHP message: INIT                : Including Plugin plugins/zzz-aboutrompr.js
    PHP message: INIT                : Including Skin Requirement jquery/jquery.hotkeys.js
    PHP message: INIT                : Including Skin Requirement jquery/jquery.mCustomScrollbar.concat.min.js
    PHP message: INIT                : Including Skin Requirement jquery/jquery.tipTip.js
    PH
    2017/02/09 15:52:55 [error] 25281#25281: *759 FastCGI sent in stderr: "PHP message: AUDIO OUTPUT        : outputid - 0
    PHP message: AUDIO OUTPUT        : outputname - My ALSA Device
    PHP message: AUDIO OUTPUT        : outputenabled - 1" while reading upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/index.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/?setup"
    2017/02/09 15:52:56 [error] 25281#25281: *759 FastCGI sent in stderr: "PHP message: SAVEPREFS           : Saving prefs
    PHP message: SAVEPREFS           : debug_enabled=8" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/saveprefs.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:56 [error] 25281#25281: *757 FastCGI sent in stderr: "PHP message: CACHE CLEANER       : Checking Cache
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/musicbrainz/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/discogs/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/wikipedia/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/lastfm/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/spotify/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/google/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/lyrics/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/imagecache/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on albumart/
    PHP message: CACHE CLEANER       : Cache has been cleaned" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/utils/cleancache.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:56 [error] 25281#25281: *757 FastCGI sent in stderr: "PHP message: SQL_CONNECT         : Connected to MySQL
    PHP message: MPD                 : Starting Collection Scan playlistinfo
    PHP message: GETPLAYLIST         : Collection scan playlistinfo finished" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/getplaylist.php?_=1486651976128 HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:56 [error] 25281#25281: *757 FastCGI sent in stderr: "PHP message: GETPLAYLIST         : Playlist Output Is Done" while reading upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/getplaylist.php?_=1486651976128 HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:56 [error] 25281#25281: *759 FastCGI sent in stderr: "PHP message: GETLOCATION         : Requesting IP address location lookup" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/utils/getgeoip.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:57 [error] 25281#25281: *757 FastCGI sent in stderr: "PHP message: DIRBROWSER          : Browsing" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/dirbrowser.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:57 [error] 25281#25281: *759 FastCGI sent in stderr: "PHP message: SQL_CONNECT         : Connected to MySQL" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/player/mpd/loadplaylists.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:57 [error] 25281#25281: *778 FastCGI sent in stderr: "PHP message: SAVEPREFS           : Saving prefs
    PHP message: SAVEPREFS           : lastfm_country_code=CH" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/saveprefs.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:52:57 [error] 25281#25281: *771 FastCGI sent in stderr: "PHP message: SQL_CONNECT         : Connected to MySQL
    PHP message: DUMPALBUMS          : Generating artist root from database" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/albums.php?item=aartistroot HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:53:08 [error] 25281#25281: *778 FastCGI sent in stderr: "PHP message: POSTCOMMAND         : Command List: update" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/player/mpd/postcommand.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:53:10 [error] 25281#25281: *778 FastCGI sent in stderr: "PHP message: PHP Warning:  Invalid argument supplied for foreach() in /var/www/myserver/htdocs/mpd/player/mpd/postcommand.php on line 29" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/player/mpd/postcommand.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/09 15:59:50 [info] 25281#25281: *846 client 137.95.169.144 closed keepalive connection
    
    telnet 
    ...
    Escape character is '^]'.
    OK MPD 0.19.0
    status
    volume: 59
    repeat: 0
    random: 0
    single: 0
    consume: 0
    playlist: 2
    playlistlength: 0
    mixrampdb: 0.000000
    state: stop
    OK
    
     
  • Fat German Productions

    Thanks. That's unusual. I think something has gone wrong in the browser. I need to see the contents of the browser's Javascript Console when you press the Collction Update button, with Debug Logging set to Level 8. Thanks.

     
  • Anonymous

    Anonymous - 2017-02-10

    ok, odd, I tried different browsers on linux and osx. Here's a javascript error (firefox) after about 10 minutes. When I press update music collection nothing gets logged to browser console..

    The object cannot be linked to the inspector without a toolbox console-output.js:3245:0
    uncaught exception: out of memory jquery-migrate-1.2.1.js:197:1
    NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIClipboardHelper.copyStringToClipboard] urlbarBindings.xml:1072:0
    The console's evaluation context changed, probably because the target window was closed or because you opened a main window from the browser console's window.
    NS_NOINTERFACE:  gDevTools.jsm:910:0
    Error: Script terminated by timeout at:
    jQuery.fn.init@http://myserver/mpd/jquery/jquery-migrate-1.2.1.js:197:1
    n@http://myserver/mpd/jquery/jquery-2.1.4.min.js:2:405
    n.prototype.pushStack@http://myserver/mpd/jquery/jquery-2.1.4.min.js:2:746
    n.fn[a]@http://myserver/mpd/jquery/jquery-2.1.4.min.js:2:26614
    ._findSourceElement@http://myserver/mpd/ui/uifunctions.js:1677:18
    e.widget/</h[t]</<@http://myserver/mpd/jquery/jquery-ui.min.js:6:4698
    ._mouseStart@http://myserver/mpd/ui/uifunctions.js:1687:41
    e.widget/</h[t]</<@http://myserver/mpd/jquery/jquery-ui.min.js:6:4698
    ._mouseMove@http://myserver/mpd/jquery/jquery-ui.min.js:6:12411
    e.widget/</h[t]</<@http://myserver/mpd/jquery/jquery-ui.min.js:6:4698
    ._mouseDown/this._mouseMoveDelegate@http://myserver/mpd/jquery/jquery-ui.min.js:6:11819
    n.event.dispatch@http://myserver/mpd/jquery/jquery-2.1.4.min.js:3:6414
    n.event.add/r.handle@http://myserver/mpd/jquery/jquery-2.1.4.min.js:3:3224
    
     
  • Anonymous

    Anonymous - 2017-02-13

    Hello,
    I increased verbosity of mpd. The problem is probably with mpd because there are a lot of "update: ignoring unrecognized file...." messages. This is very weird, it seems that mpd is having problems with a lot of mp3 and flac files now: (no idea why)

    Feb 13 10:38 : update: reading mp3/x.mp3
    Feb 13 10:38 : ffmpeg/mp3: Before avformat_find_stream_info() pos: 0 bytes read:469803136 seeks:114695
    Feb 13 10:38 : ffmpeg/mp3: decoding for stream 0 failed
    Feb 13 10:38 : ffmpeg/mp3: 0: start_time: 0.000 duration: -9223372036854.775
    Feb 13 10:38 : ffmpeg/mp3: stream: start_time: 0.000 duration: -9223372036854.775 bitrate=0 kb/s
    Feb 13 10:38 : ffmpeg/mp3: Could not find codec parameters for stream 0 (Audio: mp3, 0 channels, s16p): unspecified frame size
    Consider increasing the value for the 'analyzeduration' and 'probesize' options
    Feb 13 10:38 : ffmpeg/mp3: After avformat_find_stream_info() pos: 3444171 bytes read:473247307 seeks:114695 frames:1
    Feb 13 10:38 : update: ignoring unrecognized file mp3/x.mp3
    
    Feb 13 10:38 : update: reading FLAC/xx.flac
    Feb 13 10:38 : flac: Failed to read FLAC tags: FLAC__METADATA_CHAIN_STATUS_NOT_A_FLAC_FILE
    Feb 13 10:38 : flac: Failed to read FLAC tags: FLAC__METADATA_CHAIN_STATUS_NOT_A_FLAC_FILE
    Feb 13 10:38 : ffmpeg/flac: Before avformat_find_stream_info() pos: 0 bytes read:4096 seeks:0
    Feb 13 10:38 : ffmpeg/flac: 0: start_time: -9223372036854.775 duration: -9223372036854.775
    Feb 13 10:38 : ffmpeg/flac: stream: start_time: -9223372036854.775 duration: -9223372036854.775 bitrate=0 kb/s
    Feb 13 10:38 : ffmpeg/flac: Could not find codec parameters for stream 0 (Audio: flac, 0 channels): unspecified sample format
    Consider increasing the value for the 'analyzeduration' and 'probesize' options
    Feb 13 10:38 : ffmpeg/flac: After avformat_find_stream_info() pos: 4096 bytes read:4096 seeks:0 frames:0
    Feb 13 10:38 : update: ignoring unrecognized file xx.flac
    
     
  • Anonymous

    Anonymous - 2017-02-13

    after removing audio files causing troubles, mpd log shows the following:

    Feb 13 14:27 : update: starting
    Feb 13 14:27 : client: [29] process command "status"
    Feb 13 14:27 : client: [29] command returned 0
    Feb 13 14:27 : client: [29] process command "replay_gain_status"
    Feb 13 14:27 : client: [29] command returned 0
    Feb 13 14:27 : client: [29] closed
    Feb 13 14:27 : errno: Failed to open 'lost+found': Permission denied
    Feb 13 14:27 : update: finished
    

    I also tried with a cleared mysql database but nothing helps. THere aren't any entries now at all in mysql and the message 'updating music collection' does not disappear even though log shows it should be finished

     

    Last edit: Anonymous 2017-02-13
  • Anonymous

    Anonymous - 2017-02-13

    Thanks for that investigation Do files show up in mpc? If so please try rompr with an sqlite database as I think there may be a bug in the mysql code. Thanks

     
  • Anonymous

    Anonymous - 2017-02-13

    Thank you!!
    WHen I use mpc with ls the audio files (i.e. album folders) do show up:

    mpc -h pwd@hostip ls FLAC
    ...
    FLAC/Dimension
    FLAC/Example - ...
    ...
    
     
  • Fat German Productions

    OK please try rompr with the Lite database (SQLite) - you can configure this from rompr/?setup.

    You may need to install some packages, depending on your distro, see the docs for more information. If it works with SQLite then I know what the problem is.

     
  • Anonymous

    Anonymous - 2017-02-14

    Sadly, sqllite does not help in that regard: (library is not getting populated)

    2017/02/14 15:30:27 [error] 11726#11726: *237 FastCGI sent in stderr: "PHP message: INIT                : =================****==================
    PHP message: INIT                : Detecting window size to decide which skin to use" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/?setup HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver"
    2017/02/14 15:30:27 [error] 11726#11726: *237 FastCGI sent in stderr: "PHP message: INIT                : =================****==================
    PHP message: INIT                : Using skin as set by Cookie: desktop
    PHP message: INIT                : Using skin : desktop" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/?setup HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/?setup"
    2017/02/14 15:30:33 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: INIT                : =================****==================
    PHP message: INIT                : Using skin as set by Cookie: desktop
    PHP message: INIT                : Using skin : desktop
    PHP message: INIT                : Setting Pref currenthost to mympd
    PHP message: INIT                : Setting Pref mpd_host to 192.168.55.1
    PHP message: INIT                : Setting Pref mpd_port to 6600
    PHP message: INIT                : Setting Pref mpd_password to password
    PHP message: INIT                : Setting Pref unix_socket to /var/lib/mpd/socket
    PHP message: INIT                : Setting Pref collection_type to sqlite
    PHP message: INIT                : Setting Pref mysql_host to localhost
    PHP message: INIT                : Setting Pref mysql_port to 3306
    PHP message: INIT                : Setting Pref mysql_database to rompr
    PHP message: INIT                : Setting Pref mysql_user to rompr
    PHP message: INIT                : Setting Pref mysql_password to xadad
    PHP message: INIT                : Setting Pref proxy_host to 
    PHP message: INIT                : Setting Pref proxy_user to 
    PHP message: INIT                : Setting Pref proxy_password to 
    PHP message: INIT                : Setting Pref debug_enabled to 8
    PHP message: INIT                : Setting Pref custom_logfile to 
    PHP message: INIT                : Probing Player Type....
    PHP message: INIT                :     ....tagtypes test says we're running MPD
    PHP message: MYSQL               : Connected to SQLite
    PHP message: SQLITE_CONNECT      :   Tracktable OK
    PHP message: SQLITE_CONNECT      :     Update Trigger Created
    PHP message: SQLITE_CONNECT      :   Albumtable OK
    PHP message: SQLITE_CONNECT      :   Artisttable OK
    PHP message: SQLITE_CONNECT      :   Ratingtable OK
    PHP message: SQLITE_CONNECT      :   Tagtable OK
    PHP message: SQLITE_CONNECT      :   TagListtable OK
    PHP message: SQLITE_CONNECT      :   Playcounttable OK
    PHP message: SQLITE_CONNECT
    2017/02/14 15:30:33 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: MYSQL               : Collection has not been built0
    PHP message: INIT                : Server Address is 192.168.55.1
    PHP message: INIT                : Remote Address is 192.168.55.206
    PHP message: INIT                : Prefs for mpd host is 192.168.55.1
    PHP message: INIT                : Displaying Player IP as: 192.168.55.1
    PHP message: LAYOUT              : Including skins/desktop/skinvars.php
    PHP message: INIT                : Including Browser Helper browser/helpers/dbqueue.js
    PHP message: INIT                : Including Browser Helper browser/helpers/discogs.js
    PHP message: INIT                : Including Browser Helper browser/helpers/musicbrainz.js
    PHP message: INIT                : Including Browser Helper browser/helpers/soundcloud.js
    PHP message: INIT                : Including Browser Helper browser/helpers/spotify.js
    PHP message: INIT                : Including Browser Helper browser/helpers/wikipedia.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/01_info_file.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/02_info_lastfm.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/03_info_wikipedia.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/04_info_musicbrainz.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/05_info_discogs.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/06_info_lyrics.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/07_info_soundcloud.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/08_info_spotify.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/09_info_videos.js
    PHP message: INIT                : Including Info Panel Plugin browser/plugins/info_ratings.js
    PHP message: INIT                : Including S
    2017/02/14 15:30:33 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: AUDIO OUTPUT        : outputid - 0
    PHP message: AUDIO OUTPUT        : outputname - My ALSA Device
    PHP message: AUDIO OUTPUT        : outputenabled - 1" while reading upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/index.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/?setup"
    2017/02/14 15:30:33 [error] 11726#11726: *243 FastCGI sent in stderr: "PHP message: SAVEPREFS           : Saving prefs
    PHP message: SAVEPREFS           : debug_enabled=8" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/saveprefs.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *241 FastCGI sent in stderr: "PHP message: CACHE CLEANER       : Checking Cache
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/musicbrainz/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/discogs/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/wikipedia/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/lastfm/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/spotify/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/google/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/jsoncache/lyrics/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on prefs/imagecache/
    PHP message: CACHE CLEANER       : Cache Cleaner is running on albumart/
    PHP message: CACHE CLEANER       : Cache has been cleaned" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/utils/cleancache.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *241 FastCGI sent in stderr: "PHP message: DIRBROWSER          : Browsing" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/dirbrowser.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *237 FastCGI sent in stderr: "PHP message: MYSQL               : Connected to SQLite
    PHP message: DUMPALBUMS          : Generating artist root from database" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/albums.php?item=aartistroot HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *237 FastCGI sent in stderr: "PHP message: MYSQL               : Connected to SQLite
    PHP message: MPD                 : Starting Collection Scan playlistinfo
    PHP message: GETPLAYLIST         : Collection scan playlistinfo finished" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/getplaylist.php?_=1487082633576 HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *237 FastCGI sent in stderr: "PHP message: GETPLAYLIST         : Playlist Output Is Done" while reading upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/getplaylist.php?_=1487082633576 HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *242 FastCGI sent in stderr: "PHP message: MYSQL               : Connected to SQLite" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/player/mpd/loadplaylists.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: GETLOCATION         : Requesting IP address location lookup" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/utils/getgeoip.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:34 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: SAVEPREFS           : Saving prefs
    PHP message: SAVEPREFS           : lastfm_country_code=CH" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/saveprefs.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:43 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: POSTCOMMAND         : Command List: update" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "POST /mpd/player/mpd/postcommand.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:30:45 [error] 11726#11726: *239 FastCGI sent in stderr: "PHP message: PHP Warning:  Invalid argument supplied for foreach() in /var/www/myserver/htdocs/mpd/player/mpd/postcommand.php on line 29" while reading response header from upstream, client: 192.168.55.206, server: myserver, request: "GET /mpd/player/mpd/postcommand.php HTTP/1.1", upstream: "fastcgi://unix:/run/php-fpm.socket:", host: "myserver", referrer: "http://myserver/mpd/index.php"
    2017/02/14 15:35:25 [info] 11726#11726: *239 client 192.168.55.206 closed keepalive connection
    
     

    Last edit: Anonymous 2017-02-15
  • Anonymous

    Anonymous - 2017-02-15

    It works again. I changed back to mysql and switched from localhost to 127.0.0.1 as Mysql Server address ... probably this made the difference

     
  • Anonymous

    Anonymous - 2017-03-09

    I have pretty much the same problem, yet changing localhost to 127.0.0.1 doesn't fix it for me.
    My setup: Raspberry Pi 3 running Raspbian and mpd + a Cubietruck running Gentoo with Apache & MySQL and serving the audio files.
    I did pretty much the same as the OP (Log level 8 etc.). When I hit the "Update music collection" button Rompr's debug log says:
    15:55:15 : POSTCOMMAND Command List: update

    At the same time, "mpc status" shows
    Updating DB (#3) ...

    and finishes updating after a while, yet the Rompr web frontend still shows the "Updating music collection" message without going through the collection, though.

    It seems like it's either waiting for some return message from mpd which never shows up or it sends the update command to mpd and then gets caught in a loop. Either way, it doesn't update its database at all.

    It all worked with Rompr 0.73 but I had to update to 0.78 after PHP got updated to 7.0.15.

    I'll look into the differences between 0.73 and 0.78. Maybe I find something, even though my PHP knowledge is limited :-)

     
  • Fat German Productions

    I've bee unable to reproduce this so it's difficult to give any exact guidance, but what's supposed to happen is that once rompr sends mpd the 'update' command it then polls mpd by sending a 'status' command once every second until 'updating_db' disappears from mpd's status. It appears to the the polling that is not working.

    This is all handled by the javascript in the frontend, so a better place to look for debug output would be in your browser's Javascript Console.

    Having just looked at the code I can see an oddity that is almost certainly wrong but probably doesn't explain it. I'm looking at the code for version 1.01 by the way, which was released last week.

    Most of this stuff happens in uifunctions.js. I'm looking at

    function checkPoll(data) {
        if (data.updating_db) {
            update_load_timer = setTimeout( pollAlbumList, 1000);
            update_load_timer_running = true;
        } else {
            if (prefs.hide_filelist && !prefs.hide_albumlist) {
    

    After that "} else {" there ought to be

     update_load_timer_running = false;
    

    I very much doubt whether that is the problem though.

    If you need to get a music collection built, you can force it from the command line with

    curl -b "currenthost=Default;player_backend=mpd" http://localhost/rompr/albums.php?rebuild > /dev/null

    Once that finished, refresing rompr will show an updated collction. In fact if that works it demonstrates that the polling is the problem.

    Which browser are you using? And what version of mpd?

     
  • Anonymous

    Anonymous - 2017-03-09

    That's a quick reply!

    Browser is Firefox 45.7.0 or Chrome 54.0, it's the same on both. Mpd is 0.19.1.

    I've just updated Rompr to 1.01 and it seems that it's working again, at least it's now showing those "Scanning directory" messages after mpd's update was finished.

    Thanks for your efforts. Rompr is still the best web frontend for mpd :-)

     
  • Fat German Productions

    You got lucky, I was sat in front of a text editor with rompr open :)

    If you're seeing 'Scanning Directory...' then it's working - which is both pleasing and concerning at the same time! Perhaps it was something odd with 0.78, I did a lot of code changes between then and 1.01.

    Let me know if it happens again, I'm always interested.

     
  • Anonymous

    Anonymous - 2017-03-09

    Will do! Thanks!
    I see your concern since I've been comparing those functions between 0.73 and 0.78 and there they looked pretty much the same. So we actually don't know what caused this.

     
Want the latest updates on software, tech news, and AI?
Get latest updates about software, tech news, and AI from SourceForge directly in your inbox once a month.