unresponsive webgui / unresponsive server

Need help? Post your questions here.
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

unresponsive webgui / unresponsive server

Unread post by Matt Zornig »

Code: Select all

=========================================================================================
VERSION: MADSONIC 6.2 | BUILD: 9080.619dd31.20161222.0327
REST: MADSONIC REST API v2.5.0, SUBSONIC REST API v1.14.0
OS: Linux 3.10.77 #8451 SMP Wed Jan 4 00:31:32 CST 2017 x86_64 GNU/Linux
SERVER: jetty/8.y.z-SNAPSHOT, java 1.8.0_121, Linux 3.10.77 (amd64)
HOST: Synology NAS 1815+ (DSM 6.0.2-8451 Update 9) | CPU: INTEL Atom C2538| ARCH: X64 | MEMORY: 6GB | HDD: 36TB, RAID6
BROWSER: FF 51.x
CLIENT: see browser
JAVA: ORACLE JDK 1.8.121
DESCRIPTION: as in the topic's subject
REPRODUCIBLE: Quite often
logged in as admin
=========================================================================================
We had this very often and it leads to a not usable madsonic server.

Example1)

When I click on some link (i.e. History - Songs), which generates a list, which is very very long, the webgui loads and loads and loads. It is not possible to click on any other link then. Noting happens anymore for the user to see.

Example2)
It happens more often, on songs with special chars/umlauts. I.e. clicking on an artists from within the playqueue.

The servers log is very quite about the waiting times for the user. Nothing is happening for "ages" (as in half an hour, sometimes).
Only help (to continue clicking and listening) is to stop the madsonic package via DSM and start it again.
It may be working after an hour of waiting time, but....nobody does wait so long nowadays...

Log:

Code: Select all

[2017-03-04 21:46:39,393] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [testing]
[2017-03-04 21:47:22,940] DEBUG AbstractDao - fn::getUserSettings::queryOne:  5933 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 21:47:26,888] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  3228 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 21:47:33,232] DEBUG AbstractDao - fn::getUserByName::queryOne:  6342 ms:  select username, password, email, ldap_authenticated, bytes_streamed, bytes_downloaded, bytes_uploaded, group_id, locked, comment, approved from user where username=?
[2017-03-04 21:47:37,391] DEBUG AbstractDao - fn::getUserSettings::queryOne:  8342 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 21:47:41,865] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  7287 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 21:47:41,865] DEBUG AbstractDao - fn::getCurrentUserGroupId::getUserAccess:  4766 ms:  select group_id from user where username=?
[2017-03-04 21:47:46,924] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  14451 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 21:58:43,151] DEBUG AbstractDao - fn::getUserSettings::queryOne:  159022 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 21:58:43,151] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  505531 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 21:58:43,151] INFO MediaScannerService - WATCHDOG:SCAN: doFolderScanLibrary() started
[2017-03-04 21:58:43,151] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  345258 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:17:13,860] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  965592 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:17:13,860] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  622479 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:19:42,236] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  98725 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:19:42,237] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  861839 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 22:19:42,245] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  21982 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:19:42,245] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  451705 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 22:19:47,488] DEBUG AbstractDao - fn::getMediaFile::queryOne:  5250 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:19:47,490] DEBUG AbstractDao - fn::getMediaFile::queryOne:  1905167 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:19:47,490] DEBUG AbstractDao - fn::getTask::queryOne:  5244 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 22:19:47,491] DEBUG AbstractDao - fn::getMediaFile::queryOne:  5255 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:19:47,491] DEBUG AbstractDao - fn::getMediaFile::queryOne:  1940602 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:19:47,492] DEBUG AbstractDao - fn::getMediaFile::queryOne:  5251 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:19:51,587] DEBUG AbstractDao - fn::getTask::queryOne:  4092 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 22:19:51,589] DEBUG AbstractDao - fn::populateBookmarkPosition::getMediaFileBookmarkPosition:  4082 ms:  select POSITION_MILLIS from bookmark where media_file_id=? and username=?
[2017-03-04 22:19:55,700] DEBUG AbstractDao - fn::getTask::queryOne:  4112 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 22:19:58,772] DEBUG AbstractDao - fn::populateStarredDate::getMediaFileStarredDate:  4982 ms:  select created from starred_media_file where media_file_id=? and username=?
[2017-03-04 22:19:58,778] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  5000 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:19:58,779] DEBUG AbstractDao - fn::populateStarredDate::getMediaFileStarredDate:  4991 ms:  select created from starred_media_file where media_file_id=? and username=?
[2017-03-04 22:19:58,779] DEBUG AbstractDao - fn::populateStarredDate::getMediaFileStarredDate:  4992 ms:  select created from starred_media_file where media_file_id=? and username=?
[2017-03-04 22:19:58,779] DEBUG AbstractDao - fn::populateLovedDate::getMediaFileLovedDate:  5000 ms:  select created from loved_media_file where media_file_id=? and username=?
[2017-03-04 22:20:02,811] DEBUG AbstractDao - fn::getUserSettings::queryOne:  4031 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 22:20:02,814] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  9031 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:20:05,992] DEBUG AbstractDao - fn::getUserSettings::queryOne:  4673 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 22:20:18,470] DEBUG AbstractDao - fn::getUserSettings::queryOne:  9082 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 22:20:25,849] DEBUG AbstractDao - fn::getTask::queryOne:  30148 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 22:20:57,366] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  52758 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:20:57,366] DEBUG AbstractDao - fn::populateBookmarkPosition::getMediaFileBookmarkPosition:  50011 ms:  select POSITION_MILLIS from bookmark where media_file_id=? and username=?
[2017-03-04 22:20:59,126] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  47010 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:20:59,126] DEBUG AbstractDao - fn::getUserSettings::queryOne:  36903 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 22:20:59,126] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  39358 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 22:20:29,059] DEBUG AbstractDao - fn::getUserSettings::queryOne:  13201 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
[2017-03-04 22:21:08,142] DEBUG AbstractDao - fn::populateStarredDate::getMediaFileStarredDate:  32989 ms:  select created from starred_media_file where media_file_id=? and username=?
[2017-03-04 22:21:32,918] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  6683 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:21:37,589] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  18270 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 22:21:46,365] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  28893 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:22:04,935] DEBUG AbstractDao - fn::getTask::queryOne:  75045 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 22:22:19,122] DEBUG AbstractDao - fn::getAllMusicFolders::getAllMusicFolders:  26485 ms:  select id, path, name, enabled, changed, mf_index, mf_type, mf_groupby, mf_timer, mf_interval from music_folder
[2017-03-04 22:26:48,496] DEBUG AbstractDao - fn::populateLovedDate::getMediaFileLovedDate:  120550 ms:  select created from loved_media_file where media_file_id=? and username=?
[2017-03-04 22:26:48,496] DEBUG AbstractDao - fn::getMediaFile::queryOne:  142621 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:35:42,950] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  612482 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:36:21,708] DEBUG AbstractDao - fn::getTask::queryOne:  816693 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 22:36:21,708] DEBUG AbstractDao - fn::run::getAudioConversionsByStatus:  818374 ms:  select id, media_file_id, username, status, target_file, target_format, log_file, bit_rate, progress_seconds, created, changed, started from audio_conversion where status=? order by created
[2017-03-04 22:40:39,841] DEBUG AbstractDao - fn::populateStarredDate::getMediaFileStarredDate:  430222 ms:  select created from starred_media_file where media_file_id=? and username=?


[2017-03-04 22:47:34,521] WARN HsqlDaoHelper - Shutting down database...
[2017-03-04 22:47:34,521] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  438997 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-03-04 22:49:37,940] DEBUG AbstractDao - fn::getMediaFile::queryOne:  1255143 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-03-04 22:55:59,747] DEBUG AbstractDao - fn::populateBookmarkPosition::getMediaFileBookmarkPosition:  698545 ms:  select POSITION_MILLIS from bookmark where media_file_id=? and username=?
[2017-03-04 23:01:13,309] DEBUG AbstractDao - fn::getTask::queryOne:  1447167 ms:  select id, music_folder_id, found, scan, status, result, comment, enabled from music_folder_tasks where music_folder_id = ?
[2017-03-04 23:02:32,288] DEBUG AbstractDao - fn::getUserSettings::queryOne:  1349882 ms:  select username, locale, theme_id, final_version_notification, beta_version_notification, main_caption_cutoff, main_disc_number, main_track_number, main_artist, main_album, main_genre, main_mood, main_year, main_bit_rate, main_duration, main_format, main_file_size, main_bpm, main_composer, playlist_caption_cutoff, playlist_disc_number, playlist_track_number, playlist_artist, playlist_album, playlist_genre, playlist_mood, playlist_year, playlist_bit_rate, playlist_duration, playlist_format, playlist_file_size, playlist_bpm, playlist_composer, button_rank, button_loved, button_starred, button_play, button_playadd, button_playmore, button_addcontext, button_addnext, button_addlast, button_download, button_youtube, button_lyric, last_fm_enabled, last_fm_username, last_fm_password, transcode_scheme, show_now_playing, selected_music_folder_id, selected_genre, party_mode_enabled, now_playing_allowed, avatar_scheme, system_avatar_id, changed, show_artist_info, show_chat, list_type, playqueue_resize, leftframe_resize, customscrollbar, customaccordion, view_as, song_notification, show_left_shrinked, show_left_bar, show_left_panel, show_right_panel, show_side_panel from user_settings where username=?
very high java process usage
very high java process usage
very high cpu usage (mostly java)
very high cpu usage (mostly java)
high-cpu.png (23.33 KiB) Viewed 2421 times
top output
top output
Now, after over an hour of "friendly waiting time", the webgui is still unresponsive and loading. But nothing visual is happening.

Let me know, if I can give more/other precise information. (after shuting down the madsonic service, CPU and JAVA is still killing most of the ressources, AND after starting the madsonic server again, its still unresponsive. The "old" logfile is still being written. As you can see above. I guess, I need to kill the "old" Java process(es))

This behaviour is very simple reproduceable. (with a large/huge media library, I guess)
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: unresponsive webgui / unresponsive server

Unread post by Matt Zornig »

This is the Log after restarting the madsonic package ("old" Java instance was still running)
I don't understand, the funny overlaping times from the log file above, but it seems .... not healthy....)
I stopped this instance too via the package center, to kill the java process. unfortunately, I had to kill it via "kill -9", normal "kill" did not work.

Code: Select all

[2017-03-04 22:58:20,778] WARN HsqlDaoHelper - Checking database schema ...
[2017-03-04 22:58:32,566] INFO HSqlSchema01 - Database table 'version' not found.  Creating it.
[2017-03-04 22:59:29,783] ERROR HsqlDaoHelper - Failed to initialize database.
org.springframework.jdbc.BadSqlGrammarException: StatementCallback; bad SQL grammar [create table version (version int not null)]; nested exception is java.sql.SQLSyntaxErrorException: object name already exists: VERSION in sta
tement [create table version (version int not null)]
        at org.springframework.jdbc.support.SQLExceptionSubclassTranslator.doTranslate(SQLExceptionSubclassTranslator.java:92)
        at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:72)
        at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:80)
        at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:407)
        at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:428)
        at org.madsonic.dao.schema.hsql.HSqlSchema01.execute(HSqlSchema01.java:74)
        at org.madsonic.dao.HsqlDaoHelper.checkDatabase(HsqlDaoHelper.java:129)
        at org.madsonic.dao.HsqlDaoHelper.<init>(HsqlDaoHelper.java:58)
        at org.madsonic.dao.DaoHelperFactory.create(DaoHelperFactory.java:39)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:160)
        at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:592)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1057)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:953)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:487)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:458)
        at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:293)
        at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:223)
        at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:290)
        at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:191)
        at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveReference(BeanDefinitionValueResolver.java:328)
        at org.springframework.beans.factory.support.BeanDefinitionValueResolver.resolveValueIfNecessary(BeanDefinitionValueResolver.java:108)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.applyPropertyValues(AbstractAutowireCapableBeanFactory.java:1419)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.populateBean(AbstractAutowireCapableBeanFactory.java:1160)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:519)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:458)
        at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:293)
        at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:223)
        at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:290)
        at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:191)
        at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:636)
        at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:938)
        at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:479)
        at org.springframework.web.context.ContextLoader.configureAndRefreshWebApplicationContext(ContextLoader.java:410)
        at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:306)
        at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:112)
        at org.eclipse.jetty.server.handler.ContextHandler.callContextInitialized(ContextHandler.java:782)
        at org.eclipse.jetty.servlet.ServletContextHandler.callContextInitialized(ServletContextHandler.java:424)
        at org.eclipse.jetty.server.handler.ContextHandler.startContext(ContextHandler.java:774)
        at org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:249)
        at org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1242)
        at org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:717)
        at org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:494)
        at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:64)
        at org.eclipse.jetty.server.handler.HandlerWrapper.doStart(HandlerWrapper.java:95)
        at org.eclipse.jetty.server.Server.doStart(Server.java:282)
        at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:64)
        at org.madsonic.booter.deployer.MadsonicDeployer.deployWebApp(MadsonicDeployer.java:243)
        at org.madsonic.booter.deployer.MadsonicDeployer.<init>(MadsonicDeployer.java:100)
        at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
        at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
        at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
        at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
        at org.springframework.beans.BeanUtils.instantiateClass(BeanUtils.java:148)
        at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:87)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1032)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:985)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:487)
        at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:458)
        at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:293)
        at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:223)
        at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:290)
        at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:191)
        at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:636)
        at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:938)
        at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:479)
        at org.springframework.context.support.ClassPathXmlApplicationContext.<init>(ClassPathXmlApplicationContext.java:139)
        at org.springframework.context.support.ClassPathXmlApplicationContext.<init>(ClassPathXmlApplicationContext.java:83)
        at org.madsonic.booter.Main.<init>(Main.java:43)
        at org.madsonic.booter.Main.main(Main.java:82)
Caused by: java.sql.SQLSyntaxErrorException: object name already exists: VERSION in statement [create table version (version int not null)]
        at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
        at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)
        at org.hsqldb.jdbc.JDBCStatement.fetchResult(Unknown Source)
        at org.hsqldb.jdbc.JDBCStatement.execute(Unknown Source)
        at org.springframework.jdbc.core.JdbcTemplate$1ExecuteStatementCallback.doInStatement(JdbcTemplate.java:421)
        at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:396)
        ... 69 more
Caused by: org.hsqldb.HsqlException: object name already exists: VERSION
        at org.hsqldb.error.Error.error(Unknown Source)
        at org.hsqldb.error.Error.error(Unknown Source)
        at org.hsqldb.SchemaObjectSet.checkAdd(Unknown Source)
        at org.hsqldb.SchemaManager.checkSchemaObjectNotExists(Unknown Source)
        at org.hsqldb.StatementSchema.setOrCheckObjectName(Unknown Source)
        at org.hsqldb.StatementSchema.getResult(Unknown Source)
        at org.hsqldb.StatementSchema.execute(Unknown Source)
        at org.hsqldb.Session.executeCompiledStatement(Unknown Source)
        at org.hsqldb.Session.executeDirectStatement(Unknown Source)
        at org.hsqldb.Session.execute(Unknown Source)
        ... 73 more

[2017-03-04 22:59:29,850] INFO HsqlDaoHelper - Checking HSQLDB version: 2.3.4
[2017-03-04 22:59:30,716] INFO SettingsService - Removing obsolete property [usedVideoPlayer]
[2017-03-04 22:59:31,801] INFO SettingsService - Java: 1.8.0_121, OS: Linux
[2017-03-04 22:59:31,834] INFO SettingsService - write transcode path to property file: /bin
[2017-03-04 22:59:32,161] INFO SettingsService - ffmpeg: ffmpeg version 2.7.1 (17.08.2016) Copyright (c) 2000-2015 the FFmpeg developers
[2017-03-04 22:59:32,161] INFO SettingsService - Madsonic scanMode: NATIVE
[2017-03-04 22:59:32,179] DEBUG VersionService - Resolved local Madsonic version to: 6.2.9080.619dd31
[2017-03-04 22:59:32,297] DEBUG UserService - Checking User accounts ...
[2017-03-04 22:59:32,478] DEBUG SecurityService - Updated user default
[2017-03-04 22:59:32,478] DEBUG UserService - Checking Default User. Done
[2017-03-04 22:59:32,519] DEBUG SecurityService - Updated user guest
[2017-03-04 22:59:32,519] DEBUG UserService - Checking Guest User. Done
[2017-03-04 22:59:32,549] DEBUG SecurityService - Updated user node
[2017-03-04 22:59:32,549] DEBUG UserService - Checking Node User. Done
[2017-03-04 22:59:32,865] DEBUG MediaScannerService - WATCHDOG:RUN: doUpdateTasks()
[2017-03-04 22:59:32,916] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [Klangschale0]
[2017-03-04 22:59:32,916] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleA]
[2017-03-04 22:59:32,916] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleB]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleC]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleD]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleE]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleF]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleG]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleH]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleI]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleJ]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleK]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleL]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleM]
[2017-03-04 22:59:32,917] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleN]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleO]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleP]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleQ]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleR]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleS]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleT]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleU]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleV]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleW]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleX]
[2017-03-04 22:59:32,918] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleY]
[2017-03-04 22:59:32,919] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleZ]
[2017-03-04 22:59:32,945] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [testing]
[2017-03-04 22:59:32,971] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-07 18:09:00.0 [Klangschale0]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleA]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleB]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleC]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleD]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleE]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleF]
[2017-03-04 22:59:32,972] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleG]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleH]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleI]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleJ]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleK]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleL]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleM]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleN]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleO]
[2017-03-04 22:59:32,973] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleP]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleQ]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleR]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleS]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleT]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleU]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleV]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleW]
[2017-03-04 22:59:32,975] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleX]
[2017-03-04 22:59:32,975] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleY]
[2017-03-04 22:59:32,975] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleZ]
[2017-03-04 22:59:32,976] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-04 23:00:00.0 [testing]
[2017-03-04 22:59:32,977] INFO MediaScannerService - Automatic media scanning disabled.
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleU]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleV]
[2017-03-04 22:59:32,974] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleW]
[2017-03-04 22:59:32,975] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleX]
[2017-03-04 22:59:32,975] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleY]
[2017-03-04 22:59:32,975] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-10 01:00:00.0 [KlangschaleZ]
[2017-03-04 22:59:32,976] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-03-04 23:00:00.0 [testing]
[2017-03-04 22:59:32,977] INFO MediaScannerService - Automatic media scanning disabled.
[2017-03-04 22:59:33,691] INFO UPnPService - Checking UPnP service...
[2017-03-04 22:59:33,706] DEBUG NetworkService - Check backend interface ...
[2017-03-04 22:59:33,707] DEBUG NetworkService - Madsonic Node Discovery is disabled.
[2017-03-04 22:59:34,165] INFO PodcastService - Automatic Podcast update disabled.
[2017-03-04 22:59:35,758] INFO UPnPService - Enabling UPnP/DLNA media server
[2017-03-04 22:59:35,758] INFO UPnPService - Checking UPnP service - Done!
[2017-03-04 22:59:35,813] DEBUG JaudiotaggerParser - GenreMap turned: off
[2017-03-04 22:59:44,020] INFO NetworkService - Deleted port mapping for port 4040
[2017-03-04 22:59:56,653] DEBUG RESTController - supported MADSONIC REST version: 2.5.0
[2017-03-04 22:59:57,341] DEBUG RESTController - supported SUBSONIC REST version: 1.14.0
[2017-03-04 23:00:00,013] INFO MediaScannerService - WATCHDOG:SCAN: doFolderScanLibrary() started
[2017-03-04 23:00:01,036] INFO MediaScannerService - Scanned media library with 500 entries.
[2017-03-04 23:00:01,777] INFO MediaScannerService - Scanned media library with 1000 entries.
[2017-03-04 23:00:05,036] INFO MediaScannerService - Scanned media library with 1500 entries.
[2017-03-04 23:00:12,046] INFO MediaScannerService - Scanned media library with 2000 entries.
[2017-03-04 23:00:19,565] INFO MediaScannerService - Scanned media library with 2500 entries.
[2017-03-04 23:00:24,058] INFO MediaScannerService - Scanned media library with 3000 entries.
[2017-03-04 23:00:24,331] INFO MediaScannerService - Scanned media library with 3500 entries.
[2017-03-04 23:00:24,484] INFO MediaScannerService - Scanned media library with 4000 entries.
[2017-03-04 23:00:24,587] INFO MediaScannerService - Scanned media library with 4500 entries.
[2017-03-04 23:00:24,978] INFO MediaScannerService - Scanned media library with 5000 entries.
[2017-03-04 23:00:25,107] INFO MediaScannerService - Scanned media library with 5500 entries.
[2017-03-04 23:00:25,275] INFO MediaScannerService - Scanned media library with 6000 entries.
[2017-03-04 23:00:25,407] INFO MediaScannerService - Scanned media library with 6500 entries.
[2017-03-04 23:00:30,342] INFO MediaScannerService - Scanned media library with 7000 entries.
[2017-03-04 23:00:34,914] INFO MediaScannerService - Scanned media library with 7500 entries.
[2017-03-04 23:00:41,930] INFO MediaScannerService - Scanned media library with 8000 entries.
[2017-03-04 23:00:45,559] INFO MediaScannerService - Scanned media library with 8500 entries.
[2017-03-04 23:00:45,787] INFO MediaScannerService - Scanned media library with 9000 entries.
[2017-03-04 23:00:45,890] INFO MediaScannerService - Scanned media library with 9500 entries.
[2017-03-04 23:00:45,982] INFO MediaScannerService - Scanned media library with 10000 entries.
[2017-03-04 23:00:46,149] INFO MediaScannerService - Scanned media library with 10500 entries.
[2017-03-04 23:00:46,332] INFO MediaScannerService - Scanned media library with 11000 entries.
[2017-03-04 23:00:46,481] INFO MediaScannerService - Scanned media library with 11500 entries.
[2017-03-04 23:00:46,684] INFO MediaScannerService - Scanned media library with 12000 entries.
[2017-03-04 23:00:46,754] DEBUG MediaScannerService - WATCHDOG:RUN: doUpdateTasks()
[2017-03-04 23:00:46,767] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [Klangschale0]
[2017-03-04 23:00:46,767] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleA]
[2017-03-04 23:00:46,767] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleB]
[2017-03-04 23:00:46,767] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleC]
[2017-03-04 23:00:46,768] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleD]
[2017-03-04 23:00:46,770] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleE]
[2017-03-04 23:00:46,770] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleF]
[2017-03-04 23:00:46,770] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleG]
[2017-03-04 23:00:46,770] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleH]
[2017-03-04 23:00:46,770] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleI]
[2017-03-04 23:00:46,770] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleJ]
[2017-03-04 23:00:46,782] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleK]
[2017-03-04 23:00:46,782] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleL]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleM]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleN]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleO]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleP]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleQ]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleR]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleS]
[2017-03-04 23:00:46,786] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleT]
[2017-03-04 23:00:46,787] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleU]
[2017-03-04 23:00:46,787] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleV]
[2017-03-04 23:00:46,787] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleW]
[2017-03-04 23:00:46,787] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleX]
[2017-03-04 23:00:46,787] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleY]
[2017-03-04 23:00:46,787] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleZ]
[2017-03-04 23:00:46,799] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [testing]
[2017-03-04 23:02:56,995] WARN HsqlDaoHelper - Shutting down database...
[2017-03-04 23:02:57,706] INFO HsqlDaoHelper - Shutting down database - Done!
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: unresponsive webgui / unresponsive server

Unread post by Matt Zornig »

I found this:

Re: Madsonic Consistently Hanging
Heruwar wrote:I used to get this every few days, but haven't had any errors in a few months now after increasing JVM memory a bit with --init-memory and --max-memory.
but not capable to test it. how/where?
Post Reply