Deluged killed immediately after start after ubuntu upgrade

General support for problems installing or using Deluge
Post Reply
stavrosc
New User
New User
Posts: 4
Joined: Fri Aug 03, 2018 10:39 am

Deluged killed immediately after start after ubuntu upgrade

Post by stavrosc »

Hello,
I run deluged on a Raspberry Pi 3 with Ubuntu 16.04.5 (xfc) with thin clients on other PCs (various OSes)
Everything was working relatively smoothly until two days ago, when the deluged daemon gets killed seconds after launching.

This started the moment after I executed a regular upgrade of the OS "sudo apt-get upgrade".
The log does not give any error or warning. Just plain "Killed" a few seconds (4-10) after the initialization.
Deluged is the newest version (1.3.15-1~xenial~ppa3).
Anyone has this issue or an idea what I could look for?
Thank you in advance
stavrosc
New User
New User
Posts: 4
Joined: Fri Aug 03, 2018 10:39 am

Re: Deluged killed immediately after start after ubuntu upgrade

Post by stavrosc »

Update / correction
I missed something before: deluged logs do not show anything but journalctl shows for every time I started deluged, "out of memory":

kernel: [ 1921] 1000 1921 146308 133377 281 0 0 0 deluged
kernel: Out of memory: Kill process 1921 (deluged) score 564 or sacrifice child
kernel: Killed process 1921 (deluged) total-vm:585232kB, anon-rss:533508kB, file-rss:0kB

kernel: [ 1924] 1000 1921 146308 133453 281 0 0 0 deluged
kernel: Out of memory: Kill process 1924 (deluged) score 564 or sacrifice child
kernel: Killed process 1924 (deluged) total-vm:585232kB, anon-rss:533508kB, file-rss:304kB

kernel: [12775] 1000 12775 142862 129495 272 0 0 0 deluged
kernel: Out of memory: Kill process 12775 (deluged) score 547 or sacrifice child
kernel: Killed process 12775 (deluged) total-vm:571448kB, anon-rss:517980kB, file-rss:0kB

kernel: [13003] 1000 13003 142057 125773 270 0 0 0 deluged
kernel: Out of memory: Kill process 13003 (deluged) score 531 or sacrifice child
kernel: Killed process 13003 (deluged) total-vm:568228kB, anon-rss:503092kB, file-rss:0kB

I cannot understand why is that happening now (no application is running, system rebooted - several times, no change)
shamael
Compulsive Poster
Compulsive Poster
Posts: 667
Joined: Sat Oct 08, 2016 9:28 am

Re: Deluged killed immediately after start after ubuntu upgrade

Post by shamael »

Hi,

No log-> have you set the log level debug? https://dev.deluge-torrent.org/wiki/Tro ... gingtofile
The libtorrent version may be useful too, (command available on the same page).

So the RPI ran out of memory and the process was killed it seems. Check with "free -m" command.
the aggressivity of this function may have been changed in your last release
stavrosc
New User
New User
Posts: 4
Joined: Fri Aug 03, 2018 10:39 am

Re: Deluged killed immediately after start after ubuntu upgrade

Post by stavrosc »

Hi,

Please find below the requested data. I am not experienced enough, but with my humble abilities I cannot see something that will help me locate the issue(s):

Code: Select all

scas@scas-desktop:~$ free -m
              total        used        free      shared  buff/cache   available
Mem:            925         403         401          22         120         438
Swap:             0           0           0

Code: Select all

scas@scas-desktop:~$ deluged -L debug
scas@scas-desktop:~$ [INFO    ] 01:59:38 daemon:127 Deluge daemon 1.3.15
[DEBUG   ] 01:59:38 daemon:128 options: {'profile': False, 'read_only_config_keys': None, 'loglevel': 'debug', 'quiet': False, 'ui_interface': None, 'listen_interface': None, 'logfile': '/home/scas/.config/deluge/deluged.log', 'config': None, 'port': None, 'pidfile': None, 'donot': False}
[DEBUG   ] 01:59:38 daemon:129 args: []
[DEBUG   ] 01:59:38 core:78 Core init..
[DEBUG   ] 01:59:38 core:84 read_only_config_keys: []
[INFO    ] 01:59:38 core:87 Starting libtorrent 1.0.11.0 session..
[DEBUG   ] 01:59:38 configmanager:111 Getting config 'core.conf'
[DEBUG   ] 01:59:38 config:199 Setting 'info_sent' to 0.0 of <type 'float'>
[DEBUG   ] 01:59:38 config:199 Setting 'lsd' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'send_info' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'move_completed_path' to /home/scas/Downloads of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'enc_in_policy' to 1 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'queue_new_to_top' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'ignore_limits_on_local_network' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'rate_limit_ip_overhead' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'daemon_port' to 58846 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'torrentfiles_location' to /home/scas/Downloads of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_active_limit' to 8 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'utpex' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_active_downloading' to 3 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_active_seeding' to 5 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'allow_remote' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_half_open_connections' to 50 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'download_location' to /home/scas/Downloads of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'compact_allocation' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_upload_speed' to -1.0 of <type 'float'>
[DEBUG   ] 01:59:38 config:199 Setting 'cache_expiry' to 60 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'prioritize_first_last_pieces' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'auto_managed' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'enc_level' to 2 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_connections_per_second' to 20 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'dont_count_slow_torrents' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'random_outgoing_ports' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'dht' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'new_release_check' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'enc_out_policy' to 1 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_upload_slots_global' to 4 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'seed_time_limit' to 180 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'cache_size' to 512 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'share_ratio_limit' to 2.0 of <type 'float'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_download_speed' to -1.0 of <type 'float'>
[DEBUG   ] 01:59:38 config:199 Setting 'geoip_db_location' to /usr/share/GeoIP/GeoIP.dat of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'natpmp' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'stop_seed_at_ratio' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'peer_tos' to 0x00 of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'listen_interface' to  of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'upnp' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_download_speed_per_torrent' to -1 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'outgoing_ports' to [0, 0] of <type 'list'>
[DEBUG   ] 01:59:38 config:199 Setting 'enabled_plugins' to [] of <type 'list'>
[DEBUG   ] 01:59:38 config:199 Setting 'random_port' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'autoadd_enable' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_connections_global' to 200 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'enc_prefer_rc4' to True of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'listen_ports' to [6881, 6891] of <type 'list'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_upload_slots_per_torrent' to -1 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'stop_seed_ratio' to 2.0 of <type 'float'>
[DEBUG   ] 01:59:38 config:199 Setting 'seed_time_ratio_limit' to 7.0 of <type 'float'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_upload_speed_per_torrent' to -1 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'copy_torrent_file' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'del_copy_torrent_file' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'move_completed' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'proxies' to {'peer': {'username': '', 'password': '', 'hostname': '', 'type': 0, 'port': 8080}, 'web_seed': {'username': '', 'password': '', 'hostname': '', 'type': 0, 'port': 8080}, 'tracker': {'username': '', 'password': '', 'hostname': '', 'type': 0, 'port': 8080}, 'dht': {'username': '', 'password': '', 'hostname': '', 'type': 0, 'port': 8080}} of <type 'dict'>
[DEBUG   ] 01:59:38 config:199 Setting 'add_paused' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'max_connections_per_torrent' to -1 of <type 'int'>
[DEBUG   ] 01:59:38 config:199 Setting 'remove_seed_at_ratio' to False of <type 'bool'>
[DEBUG   ] 01:59:38 config:199 Setting 'autoadd_location' to /home/scas/Downloads of <type 'str'>
[DEBUG   ] 01:59:38 config:199 Setting 'plugins_location' to /home/scas/.config/deluge/plugins of <type 'str'>
[DEBUG   ] 01:59:38 config:394 Config /home/scas/.config/deluge/core.conf version: 1.1 loaded: {'info_sent': 0.0, 'lsd': True, 'send_info': False, 'move_completed_path': u'/media/scas/HobbitHDD/dF', 'enc_in_policy': 1, 'queue_new_to_top': True, 'ignore_limits_on_local_network': True, 'rate_limit_ip_overhead': True, 'daemon_port': 58846, 'natpmp': True, 'max_active_limit': 12, 'utpex': True, 'max_active_downloading': 7, 'max_active_seeding': 5, 'allow_remote': True, 'max_half_open_connections': 50, 'download_location': u'/media/scas/HobbitHDD/dD', 'compact_allocation': False, 'max_upload_speed': 30.0, 'cache_expiry': 60, 'prioritize_first_last_pieces': True, 'auto_managed': True, 'enc_level': 2, 'max_connections_per_second': 20, 'dont_count_slow_torrents': True, 'random_outgoing_ports': True, 'max_upload_slots_per_torrent': -1, 'new_release_check': True, 'enc_out_policy': 1, 'outgoing_ports': [0, 0], 'seed_time_limit': 180, 'cache_size': 512, 'share_ratio_limit': 2.0, 'max_download_speed': -1.0, 'geoip_db_location': u'/usr/share/GeoIP/GeoIP.dat', 'torrentfiles_location': u'/media/scas/HobbitHDD/Downloads/Done Torrents', 'stop_seed_at_ratio': False, 'peer_tos': u'0x00', 'listen_interface': u'', 'upnp': True, 'max_download_speed_per_torrent': -1, 'max_upload_slots_global': 6, 'enabled_plugins': [], 'random_port': True, 'autoadd_enable': True, 'max_connections_global': 200, 'enc_prefer_rc4': True, 'listen_ports': [6881, 6891], 'dht': True, 'stop_seed_ratio': 2.0, 'seed_time_ratio_limit': 7.0, 'max_upload_speed_per_torrent': -1, 'copy_torrent_file': True, 'del_copy_torrent_file': False, 'move_completed': True, 'proxies': {u'peer': {u'username': u'', u'password': u'', u'type': 0, u'hostname': u'', u'port': 8080}, u'web_seed': {u'username': u'', u'password': u'', u'type': 0, u'hostname': u'', u'port': 8080}, u'tracker': {u'username': u'', u'password': u'', u'type': 0, u'hostname': u'', u'port': 8080}, u'dht': {u'username': u'', u'password': u'', u'type': 0, u'hostname': u'', u'port': 8080}}, 'add_paused': False, 'max_connections_per_torrent': -1, 'remove_seed_at_ratio': False, 'autoadd_location': u'/media/scas/HobbitHDD/Downloads/New Torrents', 'plugins_location': u'/home/scas/.config/deluge/plugins'}
[DEBUG   ] 01:59:38 alertmanager:53 AlertManager initialized..
[DEBUG   ] 01:59:38 pluginmanagerbase:65 Plugin manager init..
[DEBUG   ] 01:59:38 configmanager:111 Getting config 'core.conf'
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: AutoAdd 1.5 at /usr/lib/python2.7/dist-packages/deluge/plugins/AutoAdd-1.5.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: Execute 1.3 at /usr/lib/python2.7/dist-packages/deluge/plugins/Execute-1.3.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: Blocklist 1.3 at /usr/lib/python2.7/dist-packages/deluge/plugins/Blocklist-1.3.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: Extractor 0.6 at /usr/lib/python2.7/dist-packages/deluge/plugins/Extractor-0.6.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: Label 0.2 at /usr/lib/python2.7/dist-packages/deluge/plugins/Label-0.2.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: Notifications 0.2 at /usr/lib/python2.7/dist-packages/deluge/plugins/Notifications-0.2.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: WebUi 0.1 at /usr/lib/python2.7/dist-packages/deluge/plugins/WebUi-0.1.egg
[DEBUG   ] 01:59:39 pluginmanagerbase:124 Found plugin: Scheduler 0.3 at /usr/lib/python2.7/dist-packages/deluge/plugins/Scheduler-0.3.egg
[DEBUG   ] 01:59:39 torrentmanager:127 TorrentManager init..
[DEBUG   ] 01:59:39 configmanager:111 Getting config 'core.conf'
[DEBUG   ] 01:59:39 config:306 Registering function for max_connections_per_torrent key..
[DEBUG   ] 01:59:39 torrentmanager:910 max_connections_per_torrent set to -1..
[DEBUG   ] 01:59:39 config:306 Registering function for max_upload_slots_per_torrent key..
[DEBUG   ] 01:59:39 torrentmanager:916 max_upload_slots_per_torrent set to -1..
[DEBUG   ] 01:59:39 config:306 Registering function for max_upload_speed_per_torrent key..
[DEBUG   ] 01:59:39 torrentmanager:921 max_upload_speed_per_torrent set to -1..
[DEBUG   ] 01:59:39 config:306 Registering function for max_download_speed_per_torrent key..
[DEBUG   ] 01:59:39 torrentmanager:926 max_download_speed_per_torrent set to -1..
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert torrent_finished_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert torrent_paused_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert torrent_checked_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert tracker_reply_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert tracker_announce_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert tracker_warning_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert tracker_error_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert storage_moved_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert storage_moved_failed_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert torrent_resumed_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert state_changed_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert save_resume_data_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert save_resume_data_failed_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert file_renamed_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert metadata_received_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert file_error_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert file_completed_alert
[DEBUG   ] 01:59:39 alertmanager:97 Registered handler for alert fastresume_rejected_alert
[DEBUG   ] 01:59:39 filtermanager:105 FilterManager init..
[DEBUG   ] 01:59:39 configmanager:111 Getting config 'core.conf'
[DEBUG   ] 01:59:39 config:306 Registering function for autoadd_enable key..
[DEBUG   ] 01:59:39 autoadd:124 _on_autoadd_enable
[DEBUG   ] 01:59:39 config:306 Registering function for autoadd_location key..
[DEBUG   ] 01:59:39 autoadd:131 _on_autoadd_location
[DEBUG   ] 01:59:39 configmanager:111 Getting config 'core.conf'
[INFO    ] 01:59:39 rpcserver:369 Starting DelugeRPC server :58846
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.add_torrent_file
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.add_torrent_magnet
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.add_torrent_url
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.connect_peer
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.create_torrent
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.disable_plugin
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.enable_plugin
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.force_reannounce
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.force_recheck
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_available_plugins
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_cache_status
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_config
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_config_value
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_config_values
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_enabled_plugins
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_filter_tree
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_free_space
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_libtorrent_version
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_listen_port
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_num_connections
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_path_size
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_session_state
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_session_status
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_torrent_status
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.get_torrents_status
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.glob
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.move_storage
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.pause_all_torrents
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.pause_torrent
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.queue_bottom
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.queue_down
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.queue_top
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.queue_up
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.remove_torrent
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.rename_files
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.rename_folder
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.rescan_plugins
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.resume_all_torrents
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.resume_torrent
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_config
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_auto_managed
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_file_priorities
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_max_connections
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_max_download_speed
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_max_upload_slots
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_max_upload_speed
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_move_completed
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_move_completed_path
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_options
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_prioritize_first_last
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_remove_at_ratio
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_stop_at_ratio
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_stop_ratio
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.set_torrent_trackers
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.test_listen_port
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: core.upload_plugin
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: daemon.get_method_list
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: daemon.info
[DEBUG   ] 01:59:39 rpcserver:398 Registering method: daemon.shutdown
[DEBUG   ] 01:59:39 config:306 Registering function for torrentfiles_location key..
[DEBUG   ] 01:59:39 preferencesmanager:257 Unable to make directory: [Errno 17] File exists: '/media/scas/HobbitHDD/Downloads/Done Torrents'
[DEBUG   ] 01:59:39 config:306 Registering function for listen_ports key..
[DEBUG   ] 01:59:39 config:306 Registering function for listen_interface key..
[DEBUG   ] 01:59:39 preferencesmanager:270 random port value set to True
[DEBUG   ] 01:59:39 preferencesmanager:284 listen port range set to 55026-55036
[DEBUG   ] 01:59:39 config:306 Registering function for random_port key..
[DEBUG   ] 01:59:39 preferencesmanager:270 random port value set to True
[DEBUG   ] 01:59:39 preferencesmanager:284 listen port range set to 63889-63899
[DEBUG   ] 01:59:39 config:306 Registering function for outgoing_ports key..
[DEBUG   ] 01:59:39 config:306 Registering function for random_outgoing_ports key..
[DEBUG   ] 01:59:39 config:306 Registering function for peer_tos key..
[DEBUG   ] 01:59:39 preferencesmanager:297 setting peer_tos to: 0x00
[DEBUG   ] 01:59:39 config:306 Registering function for dht key..
[DEBUG   ] 01:59:39 preferencesmanager:305 dht value set to True
[DEBUG   ] 01:59:39 config:306 Registering function for upnp key..
[DEBUG   ] 01:59:39 preferencesmanager:328 upnp value set to True
[DEBUG   ] 01:59:39 config:306 Registering function for natpmp key..
[DEBUG   ] 01:59:39 preferencesmanager:335 natpmp value set to True
[DEBUG   ] 01:59:39 config:306 Registering function for utpex key..
[DEBUG   ] 01:59:39 preferencesmanager:349 utpex value set to True
[DEBUG   ] 01:59:39 config:306 Registering function for lsd key..
[DEBUG   ] 01:59:39 preferencesmanager:342 lsd value set to True
[DEBUG   ] 01:59:39 config:306 Registering function for enc_in_policy key..
[DEBUG   ] 01:59:39 preferencesmanager:356 encryption value enc_in_policy set to 1..
[DEBUG   ] 01:59:39 preferencesmanager:371 encryption settings:
			out_policy: 1
		        in_policy: 1
			level: 3
			prefer_rc4: True
[DEBUG   ] 01:59:39 config:306 Registering function for enc_out_policy key..
[DEBUG   ] 01:59:39 preferencesmanager:356 encryption value enc_out_policy set to 1..
[DEBUG   ] 01:59:39 preferencesmanager:371 encryption settings:
			out_policy: 1
		        in_policy: 1
			level: 3
			prefer_rc4: True
[DEBUG   ] 01:59:39 config:306 Registering function for enc_level key..
[DEBUG   ] 01:59:39 preferencesmanager:356 encryption value enc_level set to 2..
[DEBUG   ] 01:59:39 preferencesmanager:371 encryption settings:
			out_policy: 1
		        in_policy: 1
			level: 3
			prefer_rc4: True
[DEBUG   ] 01:59:39 config:306 Registering function for enc_prefer_rc4 key..
[DEBUG   ] 01:59:39 preferencesmanager:356 encryption value enc_prefer_rc4 set to True..
[DEBUG   ] 01:59:39 preferencesmanager:371 encryption settings:
			out_policy: 1
		        in_policy: 1
			level: 3
			prefer_rc4: True
[DEBUG   ] 01:59:39 config:306 Registering function for max_connections_global key..
[DEBUG   ] 01:59:39 preferencesmanager:374 max_connections_global set to 200..
[DEBUG   ] 01:59:39 config:306 Registering function for max_upload_speed key..
[DEBUG   ] 01:59:39 preferencesmanager:378 max_upload_speed set to 30.0..
[DEBUG   ] 01:59:39 config:306 Registering function for max_download_speed key..
[DEBUG   ] 01:59:39 preferencesmanager:388 max_download_speed set to -1.0..
[DEBUG   ] 01:59:39 config:306 Registering function for max_upload_slots_global key..
[DEBUG   ] 01:59:39 preferencesmanager:397 max_upload_slots_global set to 6..
[DEBUG   ] 01:59:39 config:306 Registering function for max_half_open_connections key..
[DEBUG   ] 01:59:39 config:306 Registering function for max_connections_per_second key..
[DEBUG   ] 01:59:39 config:306 Registering function for ignore_limits_on_local_network key..
[DEBUG   ] 01:59:39 config:306 Registering function for share_ratio_limit key..
[DEBUG   ] 01:59:39 preferencesmanager:410 share_ratio_limit set to 2.0..
[DEBUG   ] 01:59:39 config:306 Registering function for seed_time_ratio_limit key..
[DEBUG   ] 01:59:39 preferencesmanager:414 seed_time_ratio_limit set to 7.0..
[DEBUG   ] 01:59:39 config:306 Registering function for seed_time_limit key..
[DEBUG   ] 01:59:39 preferencesmanager:418 seed_time_limit set to 180..
[DEBUG   ] 01:59:39 config:306 Registering function for max_active_downloading key..
[DEBUG   ] 01:59:39 preferencesmanager:423 max_active_downloading set to 7..
[DEBUG   ] 01:59:39 config:306 Registering function for max_active_seeding key..
[DEBUG   ] 01:59:39 preferencesmanager:427 max_active_seeding set to 5..
[DEBUG   ] 01:59:39 config:306 Registering function for max_active_limit key..
[DEBUG   ] 01:59:39 preferencesmanager:431 max_active_limit set to 12..
[DEBUG   ] 01:59:39 config:306 Registering function for dont_count_slow_torrents key..
[DEBUG   ] 01:59:39 preferencesmanager:435 dont_count_slow_torrents set to True..
[DEBUG   ] 01:59:39 config:306 Registering function for send_info key..
[DEBUG   ] 01:59:39 preferencesmanager:439 Sending anonymous stats..
[DEBUG   ] 01:59:39 config:306 Registering function for proxies key..
[DEBUG   ] 01:59:39 preferencesmanager:499 Setting proxy settings: {u'username': u'', u'password': u'', u'type': 0, u'hostname': u'', u'port': 8080}
[DEBUG   ] 01:59:39 config:306 Registering function for new_release_check key..
[DEBUG   ] 01:59:39 preferencesmanager:470 Checking for new release..
[DEBUG   ] 01:59:39 core:209 get_new_release
[DEBUG   ] 01:59:39 config:306 Registering function for rate_limit_ip_overhead key..
[DEBUG   ] 01:59:39 preferencesmanager:513 rate_limit_ip_overhead: True
[DEBUG   ] 01:59:39 config:306 Registering function for geoip_db_location key..
[DEBUG   ] 01:59:39 preferencesmanager:517 geoip_db_location: /usr/share/GeoIP/GeoIP.dat
[DEBUG   ] 01:59:39 config:306 Registering function for cache_size key..
[DEBUG   ] 01:59:39 preferencesmanager:533 cache_size: 512
[DEBUG   ] 01:59:39 config:306 Registering function for cache_expiry key..
[DEBUG   ] 01:59:39 preferencesmanager:537 cache_expiry: 60
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP] 0.0.0.0:55026
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP/SSL] 0.0.0.0:4433
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP] [::]:55026
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP/SSL] [::]:4433
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [UDP] 0.0.0.0:55026
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP] 0.0.0.0:63889
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP/SSL] 0.0.0.0:4433
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP] [::]:63889
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [TCP/SSL] [::]:4433
[DEBUG   ] 01:59:39 alertmanager:124 listen_succeeded_alert: successfully listening on [UDP] 0.0.0.0:63889
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: broadcasting search for rootdevice
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: adding port map: [ protocol: tcp ext_port: 63889 local_port: 63889 ] 
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: adding port map: [ protocol: tcp ext_port: 4433 local_port: 4433 ] 
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: adding port map: [ protocol: udp ext_port: 63889 local_port: 63889 ] 
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: NAT-PMP: found router at: 192.168.1.1
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: NAT-PMP: ==> get public IP address
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: NAT-PMP: ==> port map [ mapping: 0 action: add proto: tcp local: 63889 external: 63889 ttl: 3600 ]
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: HTTP method m-search from 192.168.1.100:45753
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: found rootdevice: http://192.168.1.1:52869/gatedesc.xml (0)
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: connecting to: http://192.168.1.1:52869/gatedesc.xml
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: HTTP method m-search from 192.168.1.100:1900
[DEBUG   ] 01:59:39 alertmanager:124 portmap_log_alert: UPnP: HTTP method m-search from 192.168.1.100:1900
[DEBUG   ] 01:59:39 configmanager:111 Getting config 'core.conf'
[DEBUG   ] 01:59:39 torrentmanager:641 Opening torrent state file for load.
[INFO    ] 01:59:39 torrentmanager:651 Successfully loaded state file: /home/scas/.config/deluge/state/torrents.state
[DEBUG   ] 01:59:39 torrentmanager:769 Opening torrents fastresume file for load.
[DEBUG   ] 01:59:40 core:221 new_release: 1.3.15
shamael
Compulsive Poster
Compulsive Poster
Posts: 667
Joined: Sat Oct 08, 2016 9:28 am

Re: Deluged killed immediately after start after ubuntu upgrade

Post by shamael »

So here it seems you run Libtorrent 1.0.11/Deluge 1.3.15 and the daemon is well started. Is this daemon killed a short time after?

The journal tells us the Deluge process was killed due to an out of memory issue on the RPI. In such constrain the Kernel kills application but Deluge didn't kill itself (Am I clear?). At a certain time the command 'free -m' should shows you no free space but it may be any program running on the RPI.
Something on the system si eating your memory and you have to figure it out
stavrosc
New User
New User
Posts: 4
Joined: Fri Aug 03, 2018 10:39 am

Re: Deluged killed immediately after start after ubuntu upgrade

Post by stavrosc »

shamael,
Thank you for your reply.
I (think) I understand the principle and that deluged does not commit suicide.
I am lost on how to start troubleshooting:
The behaviour is systematic: every time deluged is started, after few seconds it is killed, presumably (as per journalctl) because of lack of free memory..
This doesn't seem to affect other processes as far as I can see. The only process which is killed because of lack of memory is deluged!

Deluge does not log anything out of order till the moment it is killed by the kernel
The kernel does not complain about any other process nor does it kill any other process.

Running

Code: Select all

top -o %MEM
and then starting deluged, I notice that it starts modestly at a 7% then climbs rapidly at 39% and gets killed a second later
I also noticed that Teamviewer is consuming a lot of the memory (~ 30%+ between Teamviewer+, Teamviewer and teamviewerd).

Tank you in advance,
Stavros
shamael
Compulsive Poster
Compulsive Poster
Posts: 667
Joined: Sat Oct 08, 2016 9:28 am

Re: Deluged killed immediately after start after ubuntu upgrade

Post by shamael »

Under Ubuntu I think the process responsible for out of memory process kill is OOM killer. Maybe there are some rooms there to not kill specific process. However this approach will always leads to issue and I think better to substitute teamviewer with something else for example. Even at the OS level something else may suits you and spare the RPI memory
Post Reply