spksrc icon indicating copy to clipboard operation
spksrc copied to clipboard

[Radarr] Won't start on DS715 after upgrade to version 20210311-15

Open schumi2004 opened this issue 4 years ago • 19 comments

Setup

Package Name: Radarr Package Version: 20210311-15

NAS Model: DS715 NAS Architecture: Alpine DSM version: 6.2.4-25556

Package Name: Mono Package Version: 5.20.1.34-17

Expected behavior

The package should start normally from Package Center

Actual behavior

After clicking 'Run' in Package Center a windows pops up with the message 'Failed to run package service'.

Steps to reproduce

1. Installed the given update, but also a clean installation causes this behavior. v20210311-15 2. Removing and manual installing version v20201214-13 makes it work again, upgrading then brakes it.

Package log

_find logfiles in /var/packages/{package}/var/, for DSM7: /var/log/packages/{package}.log, for DSM < 6.0: protocol in Package Center. _

radarr.log 
Thu Apr  8 18:59:37 CEST 2021
Starting radarr command env HOME=/volume1/@appstore/radarr/var LD_LIBRARY_PATH=/volume1/@appstore/radarr/lib /volume1/@appstore/radarr/share/Radarr/bin/Radarr 

radarr_install.log 
Thu Apr  8 17:41:01 CEST 2021
===> Step preuninst. USER=radarr GROUP=sc-download SHARE_PATH=
Removing service configuration radarr.sc
Thu Apr  8 17:41:03 CEST 2021
===> Step postuninst. USER=radarr GROUP=sc-download SHARE_PATH=
Removing user sc-radarr
Thu Apr  8 17:43:56 CEST 2021
===> Step preinst. USER=radarr GROUP=sc-download SHARE_PATH=
Thu Apr  8 17:43:58 CEST 2021
===> Step postinst. USER=radarr GROUP=sc-download SHARE_PATH=
Installing service configuration /var/packages/radarr/conf/radarr.sc
Adding 'sc-radarr' to 'sc-download'
Group Name: [sc-download]
Group Type: [AUTH_LOCAL]
Group ID:   [65536]
Group Members: 
0:[autosub]
1:[nzbget-testing]
2:[sc-nzbdrone]
3:[sc-transmission]
4:[sc-bazarr]
5:[sc-radarr]
Invoke service_postinst
Granting 'sc-radarr' unix ownership on /volume1/@appstore/radarr/var/.config
Granting 'sc-radarr' unix ownership on /volume1/@appstore/radarr/var
Thu Apr  8 18:34:53 CEST 2021
===> Step preuninst. USER=radarr GROUP=sc-download SHARE_PATH=
Removing service configuration radarr.sc
Thu Apr  8 18:34:54 CEST 2021
===> Step postuninst. USER=radarr GROUP=sc-download SHARE_PATH=
Removing user sc-radarr
Thu Apr  8 18:37:15 CEST 2021
===> Step preinst. USER=radarr GROUP=sc-download SHARE_PATH=
Thu Apr  8 18:37:16 CEST 2021
===> Step postinst. USER=radarr GROUP=sc-download SHARE_PATH=
Installing service configuration /var/packages/radarr/conf/radarr.sc
Adding 'sc-radarr' to 'sc-download'
Group Name: [sc-download]
Group Type: [AUTH_LOCAL]
Group ID:   [65536]
Group Members: 
0:[autosub]
1:[nzbget-testing]
2:[sc-nzbdrone]
3:[sc-transmission]
4:[sc-bazarr]
5:[sc-radarr]
Invoke service_postinst
Granting 'sc-radarr' unix ownership on /volume1/@appstore/radarr/var/.config

Other logs

/var/log/messages`_

2021-04-08T18:34:56+02:00 DS715 synocgitool: hook[user_delete] Username (sc-radarr) deleted. - Kick user[sc-radarr]
2021-04-08T18:34:57+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[20590]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T18:37:16+02:00 DS715 synoscgi_SYNO.Core.Package.Installation_1_install[27071]: resource_api.cpp:190 Acquire service-cfg for radarr when 0x0001 (done)
2021-04-08T18:37:23+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[28148]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T18:37:41+02:00 DS715 [27309.999681] init: pkgctl-radarr pre-start process (27887) terminated with status 1
2021-04-08T18:37:41+02:00 DS715 synoscgi_SYNO.Core.Package.Control_1_start[26178]: servicecfg_internal_lib.c:22 Failed to start job [pkgctl-radarr][0xD900 manager.cpp:204]
2021-04-08T18:37:42+02:00 DS715 synoscgi_SYNO.Core.Package.Control_1_start[26178]: service_initjob_action.c:27 InitJobStart failed, [0xD900 manager.cpp:204]
2021-04-08T18:37:42+02:00 DS715 synoscgi_SYNO.Core.Package.Control_1_start[26178]: pkgstartstop.cpp:376 Failed to start pkgctl-radarr (err=-1) [0xD900 manager.cpp:204]
2021-04-08T18:37:43+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[30462]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T18:37:45+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[30480]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T18:59:27+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[1768]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T18:59:42+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[3058]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T18:59:57+02:00 DS715 synoscgi_SYNO.Core.Package.Control_1_start[2195]: servicecfg_internal_lib.c:22 Failed to start job [pkgctl-radarr][0xD900 manager.cpp:204]
2021-04-08T18:59:57+02:00 DS715 [28646.533619] init: pkgctl-radarr pre-start process (2624) terminated with status 1
2021-04-08T18:59:58+02:00 DS715 synoscgi_SYNO.Core.Package.Control_1_start[2195]: service_initjob_action.c:27 InitJobStart failed, [0xD900 manager.cpp:204]
2021-04-08T18:59:58+02:00 DS715 synoscgi_SYNO.Core.Package.Control_1_start[2195]: pkgstartstop.cpp:376 Failed to start pkgctl-radarr (err=-1) [0xD900 manager.cpp:204]
2021-04-08T19:00:00+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[3937]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]
2021-04-08T19:00:03+02:00 DS715 synoscgi_SYNO.Core.Synohdpack_1_getHDIcon[4420]: SYNO.Core.Synohdpack.cpp:33 The image file does not exist. [/usr/syno/synoman/webman/3rdparty/CFE/images/edit{0}.png]

/var/log/synopkg.log`_

2021/04/08 18:37:15     install radarr 20210311-15 Begin /bin/mv -f /volume1/@tmp/pkginstall/conf /var/packages/radarr/conf
2021/04/08 18:37:15     install radarr 20210311-15 End /bin/mv -f /volume1/@tmp/pkginstall/conf /var/packages/radarr/conf ret=[0]
2021/04/08 18:37:16     install radarr 20210311-15 Begin postinst
2021/04/08 18:37:17     install radarr 20210311-15 End postinst ret=[0]
2021/04/08 18:37:17     install radarr 20210311-15 Begin /bin/rm -rf /volume1/@tmp/pkginstall
2021/04/08 18:37:17     install radarr 20210311-15 End /bin/rm -rf /volume1/@tmp/pkginstall ret=[0]
2021/04/08 18:37:17     install radarr 20210311-15 successfully
2021/04/08 18:37:20     install radarr: begin to start version 20210311-15
2021/04/08 18:37:20     install radarr 20210311-15 Begin pre-load apparmor
2021/04/08 18:37:20     install radarr 20210311-15 End pre-load apparmor ret=[0]
2021/04/08 18:37:20     install radarr 20210311-15 Begin start-stop-status start
2021/04/08 18:37:41     install radarr 20210311-15 End start-stop-status start ret=[1]
2021/04/08 18:37:41     (system) trigger radarr 20210311-15 Begin start-stop-status stop
2021/04/08 18:37:41     (system) trigger radarr 20210311-15 End start-stop-status stop ret=[0]
2021/04/08 18:37:41     (system) trigger radarr 20210311-15 Begin unload apparmor
2021/04/08 18:37:41     (system) trigger radarr 20210311-15 End unload apparmor ret=[0]
2021/04/08 18:37:42     stop radarr: begin to stop version 20210311-15
2021/04/08 18:37:42     stop radarr: stop version 20210311-15 successfully, result 0
2021/04/08 18:37:42     install radarr: start version 20210311-15 failed, result 272
2021/04/08 18:59:36     start radarr: begin to start version 20210311-15
2021/04/08 18:59:37     start radarr 20210311-15 Begin pre-load apparmor
2021/04/08 18:59:37     start radarr 20210311-15 End pre-load apparmor ret=[0]
2021/04/08 18:59:37     start radarr 20210311-15 Begin start-stop-status start
2021/04/08 18:59:57     start radarr 20210311-15 End start-stop-status start ret=[1]
2021/04/08 18:59:57     (system) trigger radarr 20210311-15 Begin start-stop-status stop
2021/04/08 18:59:57     (system) trigger radarr 20210311-15 End start-stop-status stop ret=[0]
2021/04/08 18:59:58     (system) trigger radarr 20210311-15 Begin unload apparmor
2021/04/08 18:59:58     (system) trigger radarr 20210311-15 End unload apparmor ret=[0]
2021/04/08 18:59:58     stop radarr: begin to stop version 20210311-15
2021/04/08 18:59:58     stop radarr: stop version 20210311-15 successfully, result 0
2021/04/08 18:59:58     start radarr: start version 20210311-15 failed, result 272

schumi2004 avatar Apr 08 '21 17:04 schumi2004

Hi Thanks for the detailed logs and report. Your radarr.log is very short

Can you run the radarr manually using following command and tell me what the output is?

sudo su -s /bin/sh sc-radarr -c "env HOME=/volume1/@appstore/radarr/var LD_LIBRARY_PATH=/volume1/@appstore/radarr/lib /volume1/@appstore/radarr/share/Radarr/bin/Radarr"

If you get Illegal instruction (core dumped) than your CPU is not supported by dotnet -> #4528 If this is the case can you provide us your CPU info? cat /proc/cpuinfo

Thanks

publicarray avatar Apr 08 '21 23:04 publicarray

Didn't had time yet, will test and provide information tomorrow

schumi2004 avatar Apr 10 '21 21:04 schumi2004

I'm seeing the exact same behavior as the OP on a DS1817. Log entries look the same as well, specifically the result 272 error shown above in synopkg.log.

Executing the command suggested above outputs a single word Killed:

$ sudo su -s /bin/sh sc-radarr -c "env HOME=/volume1/@appstore/radarr/var LD_LIBRARY_PATH=/volume1/@appstore/radarr/lib /volume1/@appstore/radarr/share/Radarr/bin/Radarr"
Killed
$ cat /proc/cpuinfo
processor       : 0
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.7GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

processor       : 1
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.7GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

processor       : 2
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.7GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

processor       : 3
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.7GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

Hardware        : AnnapurnaLabs Alpine (Device Tree)
Revision        : 0000
Serial          : 0000000000000000

aderusha avatar Apr 11 '21 15:04 aderusha

Thanks @aderusha Killed usually means the kernel killed the process for a reason, maybe resource starvation? How much free ram do you have? @ta264 what is the minimum memory requirement? Then again seeing how many devices (3) have a problem maybe not?

Can you run the command again and copy the last few lines from the dmesg output (these are the kernel logs)? Thanks

Edit: You can also test if it is resource exhaustion by stopping all packages and restarting the NAS and only starting Radarr.

publicarray avatar Apr 13 '21 08:04 publicarray

Radarr should need max 200mb to start. Normally it idles around 150 or so for me.

That CPU has neon so should be supported afaik.

ta264 avatar Apr 13 '21 08:04 ta264

@publicarray

Did not had time to update (sorry) but here is at least the cpu info. I suspect cpu is not supported? Will upgrade later today and execute suggested command.

cat /proc/cpuinfo
processor       : 0
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.4GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt 
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

processor       : 1
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.4GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt 
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

processor       : 2
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.4GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt 
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

processor       : 3
model name      : ARMv7 Processor rev 4 (v7l)
Speed           : 1.4GHz
Features        : swp half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt 
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x2
CPU part        : 0xc0f
CPU revision    : 4

Hardware        : AnnapurnaLabs Alpine (Device Tree)
Revision        : 0000
Serial          : 0000000000000000

schumi2004 avatar Apr 13 '21 09:04 schumi2004

That CPU ought to be supported I think. The package might need fixing, but it should be fixable I think.

ta264 avatar Apr 13 '21 09:04 ta264

Thanks @aderusha Killed usually means the kernel killed the process for a reason, maybe resource starvation? How much free ram do you have?

$ free -m
              total        used        free      shared  buff/cache   available
Mem:           8173        1380         497         169        6295        6226
Swap:          2047           0        2047

Can you run the command again and copy the last few lines from the dmesg output (these are the kernel logs)? Thanks

I ran dmesg -w, executed that command, and no new output was generated.

edit: Hitting "RUN" in the UI results in the following dmesg log output:

 init: pkgctl-radarr pre-start process (19497) terminated with status 1

aderusha avatar Apr 13 '21 11:04 aderusha

@publicarray Getting the same output as @aderusha

$ sudo su -s /bin/sh sc-radarr -c "env HOME=/volume1/@appstore/radarr/var LD_LIBRARY_PATH=/volume1/@appstore/radarr/lib /volume1/@appstore/radarr/share/Radarr/bin/Radarr"
Killed

Also for dmesg output

[390776.718910] init: iscsi_pluginserverd main process (6874) killed by TERM signal
[390776.730369] init: iscsi_pluginengined main process (6873) killed by TERM signal
[390776.765227] init: scsi_plugin_server main process (6880) killed by TERM signal
[598057.970895] init: pkgctl-radarr pre-start process (32739) terminated with status 1

schumi2004 avatar Apr 15 '21 07:04 schumi2004

Thanks, So it's not your RAM. Honestly I was hoping to get more out of the logs. terminated with status 1 could mean a lot of things, for example the binary can't run on the system for some reason. Since it's .NET I don't know what it could be (I've got very little experience with it) @ta264 would you be willing to help again? I'm a bit puzzled what the pre-start process is. Is it the kernel looking for libraries to link? That could mean the included libstdc++ is wrong for this platform.

publicarray avatar Apr 19 '21 12:04 publicarray

Sure. Can you swing by the radarr discord channel when you have some free time to dig into it? https://radarr.video/discord

ta264 avatar Apr 19 '21 12:04 ta264

I have a DS918+. Since the last update of Radarr it wont start on boot. Though in my case if i manually start it then it works.

farfromrefug avatar Apr 26 '21 13:04 farfromrefug

Can't seem to join Discord, issue is still present.

schumi2004 avatar Jun 24 '21 12:06 schumi2004

I seem to have the same issue and very similar logs. Any ideas on a fix or work around?

bennyryan avatar Jul 05 '21 12:07 bennyryan

Hi and sorry for the silence, to learn more we would need a dump file. Can someone share theirs and share it in https://github.com/dotnet/runtime/issues/56706? They might be in /var/packages/radarr/target/app/ or /var/packages/radarr/var

publicarray avatar Aug 02 '21 10:08 publicarray

@publicarray i got no log there. /var/packages/radarr/target/app/ exists for only config and images there

farfromrefug avatar Aug 02 '21 16:08 farfromrefug

How do we generate this dump?

schumi2004 avatar Aug 02 '21 17:08 schumi2004

Thanks @farfromrefug

Here is the process I used to get a dump from a running process: https://github.com/publicarray/spksrc/issues/28#issuecomment-891427089: I installed the .NET SDK https://github.com/publicarray/spksrc/releases/tag/dotnet-fix

@mangod9 how do you get a memory dump from a process that crashes at launch though?

publicarray avatar Aug 03 '21 01:08 publicarray

@publicarray I don't understand what you mean with armadaxp being unsupported and/or marking it as unsupported. I'm running a recent Radarr dotnet core on my DS414 without any issues.

Radarr Details:

Version    4.0.0.5206
Package Version    armv7-6.1_20210311-15 by Team Radarr 
.NET    Yes (5.0.5)
DB Migration    196
AppData directory    /volume1/@appstore/radarr/var/.config/Radarr
Startup directory    /volume1/@appstore/radarr/share/Radarr/bin
Mode    Console
$ cat /proc/cpuinfo 
Processor	: Marvell PJ4Bv7 Processor rev 2 (v7l)
processor	: 0
BogoMIPS	: 1332.01

processor	: 1
BogoMIPS	: 1332.01

Features	: swp half thumb fastmult vfp edsp vfpv3 tls 
CPU implementer	: 0x56
CPU architecture: 7
CPU variant	: 0x2
CPU part	: 0x584
CPU revision	: 2

Hardware	: Marvell Armada XP Development Board
Revision	: 0000
Serial		: 0000000000000000

AnonTester avatar Aug 26 '21 23:08 AnonTester

@schumi2004 @AnonTester @aderusha, I've been trying to solicit feedback to confirm compatibility with .NET builds of Radarr, Lidarr and Sonarr v4 running on ARMv7 architectures. If you have the time perhaps you can check out https://github.com/SynoCommunity/spksrc/issues/5574 and add your feedback on the test packages I've shared. Appreciate the support.

mreid-tt avatar Jan 24 '23 11:01 mreid-tt

@schumi2004, a new version of Radarr (v20230215-19) has been published. This version includes Radarr 4.3.2.6857 and removes support for armada370 which is not dotnet 6 compatible as well as armv7 archs running under DSM 6 (as it does not have the required libraries).

In your original note you mentioned your setup was:

NAS Model: DS715 (Alpine)
DSM version: 6.2.4-25556

Based on this setup Radarr will not be compatible unless you upgrade to DSM 7.1. If this is not an option you can consider running one of the Servarr builds from https://github.com/Servarr/spksrc/releases which include a special wrapper for running dotnet apps on older architectures.

mreid-tt avatar Feb 19 '23 12:02 mreid-tt

@schumi2004, I wanted to follow up on your issue. Have you had a chance to try my suggested solution? Please let me know if it resolves the issue. If I don't hear back from you in the next few days, I'll assume the issue has been resolved and will close it.

mreid-tt avatar Mar 27 '23 11:03 mreid-tt

@mreid-tt I completely missed your previous message. The issue is that I moved away from running packages on my DS715 but to help other people I will upgrade DSM to 7.1 and see if it runs.

/Edit Upgraded to DSM 7.1 and updated Radarr but it didn't run, will try again tomorrow

schumi2004 avatar Mar 27 '23 20:03 schumi2004

hey @schumi2004, thanks much for the update. This is indeed strange. If you can, I'd like you to SSH into your NAS and share with me the results of:

cat /etc.defaults/VERSION
cat /var/packages/radarr/INFO | grep -v package_icon
tail -n 100 /var/log/packages/radarr.log
ls -all /volume1/*.core.gz

I noted above you already shared your cpu info (https://github.com/SynoCommunity/spksrc/issues/4546#issuecomment-818578558) so I won't need that again.

I may have to update the results of my original testing based on the results.

EDIT: I have another issue with a similar processor (https://github.com/SynoCommunity/spksrc/issues/5302) and you may be experiencing the same issue. Looking forward to the SSH output above to confirm.

mreid-tt avatar Mar 28 '23 11:03 mreid-tt

It seems that AnnapurnaLabs Alpine CPUs are not compatible with dotnet 6.0. They have been excluded from future builds of Radarr and other packages which use dotnet 6.0.

mreid-tt avatar Apr 02 '23 17:04 mreid-tt