Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

ruTorrent 3.10 fails to start after first time install on DSM 7 #5668

Closed
1 task done
voidfel opened this issue Mar 18, 2023 · 24 comments · Fixed by #5669
Closed
1 task done

ruTorrent 3.10 fails to start after first time install on DSM 7 #5668

voidfel opened this issue Mar 18, 2023 · 24 comments · Fixed by #5669
Labels
bug

Comments

@voidfel
Copy link

voidfel commented Mar 18, 2023 •
edited
Loading

Is this a new Bug?

  • I checkd that the bug hasn't been reported before

Package Name

ruTorrent

Package Version

3.10-13

Device Model

DS920+

Device Architecture

x86_64

Firmware Version

DSM 7.1.1-42962 Update 4

What happened?

Dear Support,

This is a first time installation of ruTorrent 3.10 on my new DS920+ with DSM 7. All dependencies (Web Station, Python and PHP) are installed. Fails to start after installation; gives an error 502 after I click "Open" from the Package Center.

image host

Something is not working properly in Web Station too? Might be related?

imgbox

Reproduction steps

1. Install the ruTorrent Package
2. Click Open from the Package Center
3. Error 502
...

Install Log

2023/03/18 13:05:59	install rutorrent 3.10-13 Begin preinst
2023/03/18 13:05:59	Begin load_variables_from_file
2023/03/18 13:05:59	End load_variables_from_file
2023/03/18 13:05:59	Begin initialize_variables
2023/03/18 13:05:59	End initialize_variables
2023/03/18 13:05:59	===> Step preinst. STATUS=INSTALL USER=sc-rutorrent GROUP=sc-download SHARE_PATH=/volume1/Videos
2023/03/18 13:05:59	Begin validate_preinst
2023/03/18 13:05:59	End validate_preinst
2023/03/18 13:05:59	install rutorrent 3.10-13 End preinst ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mkdir -p /volume1/@appstore/rutorrent -m 755
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mkdir -p /volume1/@appstore/rutorrent -m 755 ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/rm -rf /volume1/@appstore/rutorrent
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/rm -rf /volume1/@appstore/rutorrent ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/package /volume1/@appstore/rutorrent
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/package /volume1/@appstore/rutorrent ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/rm -rf /var/packages/rutorrent
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/rm -rf /var/packages/rutorrent ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mkdir -p /var/packages/rutorrent -m 755
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mkdir -p /var/packages/rutorrent -m 755 ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/touch /var/packages/rutorrent/installing
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/touch /var/packages/rutorrent/installing ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/INFO /var/packages/rutorrent/INFO
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/INFO /var/packages/rutorrent/INFO ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/rm -rf /var/packages/rutorrent/scripts
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/rm -rf /var/packages/rutorrent/scripts ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/scripts /var/packages/rutorrent/scripts
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/scripts /var/packages/rutorrent/scripts ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/rm -rf /var/packages/rutorrent/WIZARD_UIFILES
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/rm -rf /var/packages/rutorrent/WIZARD_UIFILES ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/WIZARD_UIFILES /var/packages/rutorrent/WIZARD_UIFILES
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/WIZARD_UIFILES /var/packages/rutorrent/WIZARD_UIFILES ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/rm -rf /var/packages/rutorrent/conf
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/rm -rf /var/packages/rutorrent/conf ret=[0]
2023/03/18 13:05:59	install rutorrent 3.10-13 Begin /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/conf /var/packages/rutorrent/conf
2023/03/18 13:05:59	install rutorrent 3.10-13 End /bin/mv -f /volume1/@tmp/synopkg/install.8IrOYI/conf /var/packages/rutorrent/conf ret=[0]
2023/03/18 13:06:02	install rutorrent 3.10-13 Begin postinst
2023/03/18 13:06:02	Begin load_variables_from_file
2023/03/18 13:06:02	End load_variables_from_file
2023/03/18 13:06:02	Begin initialize_variables
2023/03/18 13:06:02	End initialize_variables
2023/03/18 13:06:02	===> Step postinst. STATUS=INSTALL USER=sc-rutorrent GROUP=sc-download SHARE_PATH=/volume1/Videos
2023/03/18 13:06:02	Begin save_wizard_variables
2023/03/18 13:06:02	End save_wizard_variables
2023/03/18 13:06:02	Begin syno_sync_var_folder
2023/03/18 13:06:02	Install files from var folder
2023/03/18 13:06:02	/bin/rsync -avh --ignore-existing --remove-source-files /volume1/@appstore/rutorrent/var/ /volume1/@appdata/rutorrent
2023/03/18 13:06:02	sending incremental file list
2023/03/18 13:06:02	./
2023/03/18 13:06:02	rtorrent.rc
2023/03/18 13:06:02	.session/
2023/03/18 13:06:02	sent 750 bytes  received 50 bytes  1.60K bytes/sec
2023/03/18 13:06:02	total size is 586  speedup is 0.73
2023/03/18 13:06:02	/bin/rsync -avh --remove-source-files /volume1/@appstore/rutorrent/var/ /volume1/@appdata/rutorrent
2023/03/18 13:06:02	sending incremental file list
2023/03/18 13:06:02	./
2023/03/18 13:06:02	sent 107 bytes  received 20 bytes  254.00 bytes/sec
2023/03/18 13:06:02	total size is 0  speedup is 0.00
2023/03/18 13:06:02	End syno_sync_var_folder
2023/03/18 13:06:02	Begin service_postinst
2023/03/18 13:06:03	Python 3.10.10
2023/03/18 13:06:10	Requirement already satisfied: pip in /volume1/@appstore/rutorrent/env/lib/python3.10/site-packages (22.3.1)
2023/03/18 13:06:11	Collecting pip
2023/03/18 13:06:11	  Downloading pip-23.0.1-py3-none-any.whl (2.1 MB)
2023/03/18 13:06:11	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.1/2.1 MB 13.9 MB/s eta 0:00:00
2023/03/18 13:06:11	Installing collected packages: pip
2023/03/18 13:06:11	  Attempting uninstall: pip
2023/03/18 13:06:11	    Found existing installation: pip 22.3.1
2023/03/18 13:06:12	    Uninstalling pip-22.3.1:
2023/03/18 13:06:12	      Successfully uninstalled pip-22.3.1
2023/03/18 13:06:14	Successfully installed pip-23.0.1
2023/03/18 13:06:14	Install packages from wheels
2023/03/18 13:06:14	Install packages from wheels [/volume1/@appstore/rutorrent/share/wheelhouse/requirements.txt]
2023/03/18 13:06:15	Looking in links: /volume1/@appstore/rutorrent/share/wheelhouse
2023/03/18 13:06:15	Collecting cloudscraper==1.2.58
2023/03/18 13:06:15	  Downloading cloudscraper-1.2.58-py2.py3-none-any.whl (96 kB)
2023/03/18 13:06:16	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 96.3/96.3 kB 665.2 kB/s eta 0:00:00
2023/03/18 13:06:16	Collecting requests-toolbelt>=0.9.1
2023/03/18 13:06:16	  Downloading requests_toolbelt-0.10.1-py2.py3-none-any.whl (54 kB)
2023/03/18 13:06:16	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.5/54.5 kB 643.7 kB/s eta 0:00:00
2023/03/18 13:06:16	Collecting pyparsing>=2.4.7
2023/03/18 13:06:16	  Downloading pyparsing-3.0.9-py3-none-any.whl (98 kB)
2023/03/18 13:06:16	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.3/98.3 kB 1.4 MB/s eta 0:00:00
2023/03/18 13:06:16	Collecting requests>=2.9.2
2023/03/18 13:06:16	  Downloading requests-2.28.2-py3-none-any.whl (62 kB)
2023/03/18 13:06:16	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.8/62.8 kB 870.7 kB/s eta 0:00:00
2023/03/18 13:06:16	Collecting idna<4,>=2.5
2023/03/18 13:06:16	  Downloading idna-3.4-py3-none-any.whl (61 kB)
2023/03/18 13:06:16	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.5/61.5 kB 846.1 kB/s eta 0:00:00
2023/03/18 13:06:17	Collecting certifi>=2017.4.17
2023/03/18 13:06:17	  Downloading certifi-2022.12.7-py3-none-any.whl (155 kB)
2023/03/18 13:06:17	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 155.3/155.3 kB 1.7 MB/s eta 0:00:00
2023/03/18 13:06:17	Collecting charset-normalizer<4,>=2
2023/03/18 13:06:17	  Downloading charset_normalizer-3.1.0-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (199 kB)
2023/03/18 13:06:17	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.3/199.3 kB 3.0 MB/s eta 0:00:00
2023/03/18 13:06:17	Collecting urllib3<1.27,>=1.21.1
2023/03/18 13:06:17	  Downloading urllib3-1.26.15-py2.py3-none-any.whl (140 kB)
2023/03/18 13:06:17	     ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 140.9/140.9 kB 1.7 MB/s eta 0:00:00
2023/03/18 13:06:17	Installing collected packages: urllib3, pyparsing, idna, charset-normalizer, certifi, requests, requests-toolbelt, cloudscraper
2023/03/18 13:06:18	  Attempting uninstall: certifi
2023/03/18 13:06:18	    Found existing installation: certifi 2022.12.7
2023/03/18 13:06:18	    Not uninstalling certifi at /volume1/@appstore/python310/lib/python3.10/site-packages, outside environment /volume1/@appstore/rutorrent/env
2023/03/18 13:06:18	    Can't uninstall 'certifi'. No files were found to uninstall.
2023/03/18 13:06:19	Successfully installed certifi-2022.12.7 charset-normalizer-3.1.0 cloudscraper-1.2.58 idna-3.4 pyparsing-3.0.9 requests-2.28.2 requests-toolbelt-0.10.1 urllib3-1.26.15
2023/03/18 13:06:19	Installed modules:
2023/03/18 13:06:20	certifi==2022.12.7
2023/03/18 13:06:20	charset-normalizer==3.1.0
2023/03/18 13:06:20	cloudscraper==1.2.58
2023/03/18 13:06:20	distlib==0.3.6
2023/03/18 13:06:20	filelock==3.9.0
2023/03/18 13:06:20	idna==3.4
2023/03/18 13:06:20	platformdirs==3.0.0
2023/03/18 13:06:20	pyparsing==3.0.9
2023/03/18 13:06:20	requests==2.28.2
2023/03/18 13:06:20	requests-toolbelt==0.10.1
2023/03/18 13:06:20	six==1.16.0
2023/03/18 13:06:20	urllib3==1.26.15
2023/03/18 13:06:20	virtualenv==20.19.0
2023/03/18 13:06:20	Fixing shared folder rights for /volume1/@appstore/rutorrent/tmp
2023/03/18 13:06:20	Fixing shared folder access for everyone
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20	Fixing shared folder access for user:sc-rutorrent
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20		 [1] user:sc-rutorrent:allow:rwxpdDaARWc--:fd-- (level:0)
2023/03/18 13:06:20	Fixing shared folder access for group:sc-download
2023/03/18 13:06:20	(synoacltool.c, 253)No such Group 
2023/03/18 13:06:20	Fixing shared folder access for user:http
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20		 [1] user:http:allow:rwxp-D-------:fd-- (level:0)
2023/03/18 13:06:20		 [2] user:sc-rutorrent:allow:rwxpdDaARWc--:fd-- (level:0)
2023/03/18 13:06:20	Fixing shared folder access for group:http
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20		 [1] group:http:allow:rwxp-D-------:fd-- (level:0)
2023/03/18 13:06:20		 [2] user:sc-rutorrent:allow:rwxpdDaARWc--:fd-- (level:0)
2023/03/18 13:06:20		 [3] user:http:allow:rwxp-D-------:fd-- (level:0)
2023/03/18 13:06:20	find "/volume1/@appstore/rutorrent/tmp" -mindepth 1 -type d -exec synoacltool -enforce-inherit {} \;
2023/03/18 13:06:20	Fixing shared folder rights for /var/services/web_packages/rutorrent/share
2023/03/18 13:06:20	Fixing shared folder access for everyone
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20	Fixing shared folder access for user:sc-rutorrent
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20		 [1] user:sc-rutorrent:allow:rwxpdDaARWc--:fd-- (level:0)
2023/03/18 13:06:20	Fixing shared folder access for group:sc-download
2023/03/18 13:06:20	(synoacltool.c, 253)No such Group 
2023/03/18 13:06:20	Fixing shared folder access for user:http
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20		 [1] user:http:allow:rwxp-D-------:fd-- (level:0)
2023/03/18 13:06:20		 [2] user:sc-rutorrent:allow:rwxpdDaARWc--:fd-- (level:0)
2023/03/18 13:06:20	Fixing shared folder access for group:http
2023/03/18 13:06:20	ACL version: 1 
2023/03/18 13:06:20	Archive: has_ACL,is_support_ACL 
2023/03/18 13:06:20	Owner: [sc-rutorrent(user)] 
2023/03/18 13:06:20	--------------------- 
2023/03/18 13:06:20		 [0] everyone::allow:r-x----------:fd-- (level:0)
2023/03/18 13:06:20		 [1] group:http:allow:rwxp-D-------:fd-- (level:0)
2023/03/18 13:06:20		 [2] user:sc-rutorrent:allow:rwxpdDaARWc--:fd-- (level:0)
2023/03/18 13:06:20		 [3] user:http:allow:rwxp-D-------:fd-- (level:0)
2023/03/18 13:06:20	find "/var/services/web_packages/rutorrent/share" -mindepth 1 -type d -exec synoacltool -enforce-inherit {} \;
2023/03/18 13:06:20	End service_postinst
2023/03/18 13:06:20	install rutorrent 3.10-13 End postinst ret=[0]
2023/03/18 13:06:21	install rutorrent 3.10-13 Begin start-stop-status start
2023/03/18 13:06:21	install rutorrent 3.10-13 End start-stop-status start ret=[0]

Service Log

1679130381 W Ignoring rtorrent.rc.

Other Logs

Here are all the files. Note, I replaced my real hostname with HOST_NAME and real IP address with HOST_IP.

/var/log/systemd/nginx.service.log

2023-03-18T14:10:24+04:00 HOST_NAME synow3tool[3337]: Start Nginx Server in Normal Mode ......

/var/log/systemd/pkgctl-rutorrent.service.log

2023-03-18T14:10:23+04:00 HOST_NAME bash[3250]: ======== start rutorrent ========

/var/log/synoscgi.log

2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_delete[331]: APIRunner.cpp:1346 Bad fork logic escape from webapi process lib, just _exit
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[346]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[346]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[346]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.WebStation.PHP_1_get[356]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.WebStation.PHP_1_get[359]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.WebStation.PHP_1_get[362]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:09:14+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_install[892]: cert_config.cpp:84 Empty list, skip installing certificate
2023-03-18T14:09:20+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_delete[1610]: APIRunner.cpp:1346 Bad fork logic escape from webapi process lib, just _exit
2023-03-18T14:09:52+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation.Download_1_check[2297]: pkgverify.cpp:299 Failed to verify package, spk=[/volume1/@tmp/synopkg/download.EUXaW1/@SYNOPKG_DOWNLOAD_rutorrent] result=[{"action":"prepare","beta":false,"betaIncoming":false,"error":{"code":289,"description":"spk is not from synology"},"installReboot":false,"package":"rutorrent","packageName":"ruTorrent","stage":"prepare","success":false,"version":"3.10-13"}]
2023-03-18T14:10:01+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_install[2391]: pkgverify.cpp:299 Failed to verify package, spk=[/volume1/@tmp/synopkg/download.EUXaW1/@SYNOPKG_DOWNLOAD_rutorrent] result=[{"action":"prepare","beta":false,"betaIncoming":false,"error":{"code":289,"description":"spk is not from synology"},"installReboot":false,"package":"rutorrent","packageName":"ruTorrent","stage":"prepare","success":false,"version":"3.10-13"}]
2023-03-18T14:10:03+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_install[2560]: web_service_worker.cpp:917 Start to run web service worker install action
2023-03-18T14:10:24+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_delete[3567]: APIRunner.cpp:1346 Bad fork logic escape from webapi process lib, just _exit

/var/log/systemd.log

2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Reloaded System Logger Daemon.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Reloaded Synology Schedule Daemon.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Started PHP7.4's service unit.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:08:48+04:00 HOST_NAME systemd[1]: Stopping Synology Task Scheduler Vmtouch...
2023-03-18T14:08:48+04:00 HOST_NAME systemd[1]: Started Synology Task Scheduler Vmtouch.
2023-03-18T14:08:48+04:00 HOST_NAME systemd[1]: Starting Synology Task Scheduler Vmtouch...
2023-03-18T14:09:14+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:14+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:09:15+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:16+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:09:16+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:09:16+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:17+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:09:17+04:00 HOST_NAME systemd[1]: Starting WebStation's service unit...
2023-03-18T14:09:18+04:00 HOST_NAME systemd[1]: Reloaded System Logger Daemon.
2023-03-18T14:09:18+04:00 HOST_NAME systemd[1]: Reloaded Synology SCGI.
2023-03-18T14:09:18+04:00 HOST_NAME systemd[1]: Reloaded Synology Cron Daemon.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloaded Synology Schedule Daemon.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Stopping Synology Task Scheduler Vmtouch...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started Synology Task Scheduler Vmtouch.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Starting Synology Task Scheduler Vmtouch...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started WebStation's service unit.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Starting WebStation PHP7.4 fpm process...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Starting WebStation fcgiWrap daemon...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started WebStation PHP7.4 fpm process.
2023-03-18T14:09:19+04:00 HOST_NAME webstation_systemd_service_tool.sh[1504]: /usr/bin/mknod: /run/suphp_log: File exists
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started WebStation fcgiWrap daemon.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:20+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:04+04:00 HOST_NAME systemd[1]: Reloaded WebStation PHP7.4 fpm process.
2023-03-18T14:10:04+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:10:04+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:10:05+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Starting rutorrent's service unit...
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Reloaded WebStation PHP7.4 fpm process.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Starting WebStation PHP7.4 fpm process...
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Started WebStation PHP7.4 fpm process.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Reloaded Synology Schedule Daemon.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Started rutorrent's service unit.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:25+04:00 HOST_NAME systemd[1]: Stopping Synology Task Scheduler Vmtouch...
2023-03-18T14:10:25+04:00 HOST_NAME systemd[1]: Started Synology Task Scheduler Vmtouch.
2023-03-18T14:10:25+04:00 HOST_NAME systemd[1]: Starting Synology Task Scheduler Vmtouch...

/var/log/nginx/error_default.log

2023/03/18 14:09:15 [warn] 1015#1015: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1015#1015: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1022#1022: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1022#1022: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1029#1029: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1029#1029: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1033#1033: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1033#1033: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1038#1038: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1038#1038: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1165#1165: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1165#1165: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1167#1167: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1167#1167: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1169#1169: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1169#1169: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [notice] 1169#1169: signal process started
2023/03/18 14:09:18 [warn] 1411#1411: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:18 [warn] 1411#1411: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1420#1420: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1420#1420: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1431#1431: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1431#1431: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [notice] 1431#1431: signal process started
2023/03/18 14:09:19 [warn] 1451#1451: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1451#1451: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1460#1460: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1460#1460: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1467#1467: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1467#1467: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [notice] 1467#1467: signal process started
2023/03/18 14:10:03 [warn] 2625#2625: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:03 [warn] 2625#2625: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2650#2650: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2650#2650: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2663#2663: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2663#2663: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2680#2680: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2680#2680: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2683#2683: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2683#2683: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [notice] 2683#2683: signal process started
2023/03/18 14:10:23 [warn] 3334#3334: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:23 [warn] 3334#3334: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:23 [warn] 3343#3343: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:23 [warn] 3343#3343: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3351#3351: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3351#3351: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3361#3361: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3361#3361: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [notice] 3361#3361: signal process started

/var/log/nginx/error.log

2023/03/18 14:11:21 [error] 3365#3365: *67757 connect() failed (111: Connection refused) while connecting to upstream, client: LAPTOP_IP, server: _, request: "GET /rutorrent/ HTTP/1.1", upstream: "http://127.0.0.1:915/rutorrent/", host: "HOST_IP", referrer: "http://HOST_IP:5000/"
2023/03/18 14:11:21 [error] 3365#3365: *67760 open() "/var/services/web/missing" failed (2: No such file or directory), client: LAPTOP_IP, server: , request: "GET /missing HTTP/1.1", host: "HOST_IP", referrer: "http://HOST_IP/rutorrent/"
@voidfel voidfel added the bug label Mar 18, 2023
@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

I did a fresh install of rutorrent 3.10-13 on DS115j with DSM 7.1.1-42962 Update 4 and have no such issues.

rtorrent_web_portal

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

@voidfel please provide the log file /var/packages/rutorrent/var/rtorrent.log.

mine has only one line

# cat rtorrent.log
1679129347 W Ignoring rtorrent.rc.

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023

During installation it asked what I want to use as download folder, and I changed from default value "downloads" to "Videos".

As for the /var/packages/rutorrent/var/rtorrent.log file I also have one line:

1679130381 W Ignoring rtorrent.rc.

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

@voidfel did you create the shared folder "Videos" before the installation of ruTorrent, or had the installer to create the share?

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023

Already had the folder created; same folder that Deluge uses by the way.

I also checked Permissions of Videos shared folder. Both "sc-deluge" and "sc-rutorrent" have Read/Write access.

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

My initial installation was using the default download folder.
I now reinstalled with creation of a new share "Videos" by the installer and all works as expected.

Did you chose a watch folder in the installation wizard? (I tried a watch folder, but could not complete the installation, due to the watch folder was not found - as it does not exist in the shared folder that will be created a installation....)

probably we will have to analyze some other log files....

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023

Nope, I left the watch folder blank in the installation wizard.

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

please look in the following log files for errors related to rutorrent installation:

in the nginx log I can see that nginx is restarted

/var/log/systemd/nginx.service.log

probably you find errors in:

/var/log/systemd/pkgctl-rutorrent.service.log

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023

Just curious, in your Web Station, when you click on ruTorrent and then Edit, is that what you have too?

image host

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023 •
edited
Loading

Further log files to analyze:

/var/log/synoscgi.log
/var/log/systemd.log
/var/log/nginx/error_default.log
/var/log/nginx/error.log

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

Just curious, in your Web Station, when you click on ruTorrent and then Edit, is that what you have too?

I had nothing to edit here and see the same values as in your screenshot (but in german ;-))

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

Just added two log files to the list above...

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023 •
edited
Loading

Do you have apache 2.4 and php 7.4 installed/enabled (now in english)?

rutorrent_web_station_status

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

The nginx log should not be related to this installation (but AFAICR i saw a nginx restart there)

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023

Do you have apache 2.4 and php 7.4 installed/enabled (now in english)?

rutorrent_web_station_status

No, only NGINX and PHP 7.4 are installed. The rest is not.

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023

The log files are so big. I am going to uninstall Web Station and ruTorrent, delete log files, install Web Station, install ruTorrent, then post log files.

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023 •
edited
Loading

Here are all the files. Note, I replaced my real hostname with HOST_NAME and real IP address with HOST_IP.

/var/log/systemd/nginx.service.log

2023-03-18T14:10:24+04:00 HOST_NAME synow3tool[3337]: Start Nginx Server in Normal Mode ......

/var/log/systemd/pkgctl-rutorrent.service.log

2023-03-18T14:10:23+04:00 HOST_NAME bash[3250]: ======== start rutorrent ========

/var/log/synoscgi.log

2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_delete[331]: APIRunner.cpp:1346 Bad fork logic escape from webapi process lib, just _exit
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[346]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[346]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[346]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.WebStation.PHP_1_get[356]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.WebStation.PHP_1_get[359]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.Entry.Request_1_request[350]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:08:48+04:00 HOST_NAME synoscgi_SYNO.WebStation.PHP_1_get[362]: APIRunner.cpp:506 WebAPI SYNO.WebStation.PHP is not valid
2023-03-18T14:09:14+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_install[892]: cert_config.cpp:84 Empty list, skip installing certificate
2023-03-18T14:09:20+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_delete[1610]: APIRunner.cpp:1346 Bad fork logic escape from webapi process lib, just _exit
2023-03-18T14:09:52+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation.Download_1_check[2297]: pkgverify.cpp:299 Failed to verify package, spk=[/volume1/@tmp/synopkg/download.EUXaW1/@SYNOPKG_DOWNLOAD_rutorrent] result=[{"action":"prepare","beta":false,"betaIncoming":false,"error":{"code":289,"description":"spk is not from synology"},"installReboot":false,"package":"rutorrent","packageName":"ruTorrent","stage":"prepare","success":false,"version":"3.10-13"}]
2023-03-18T14:10:01+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_install[2391]: pkgverify.cpp:299 Failed to verify package, spk=[/volume1/@tmp/synopkg/download.EUXaW1/@SYNOPKG_DOWNLOAD_rutorrent] result=[{"action":"prepare","beta":false,"betaIncoming":false,"error":{"code":289,"description":"spk is not from synology"},"installReboot":false,"package":"rutorrent","packageName":"ruTorrent","stage":"prepare","success":false,"version":"3.10-13"}]
2023-03-18T14:10:03+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_install[2560]: web_service_worker.cpp:917 Start to run web service worker install action
2023-03-18T14:10:24+04:00 HOST_NAME synoscgi_SYNO.Core.Package.Installation_1_delete[3567]: APIRunner.cpp:1346 Bad fork logic escape from webapi process lib, just _exit

/var/log/systemd.log

2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Reloaded System Logger Daemon.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Reloaded Synology Schedule Daemon.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Started PHP7.4's service unit.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:08:47+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:08:48+04:00 HOST_NAME systemd[1]: Stopping Synology Task Scheduler Vmtouch...
2023-03-18T14:08:48+04:00 HOST_NAME systemd[1]: Started Synology Task Scheduler Vmtouch.
2023-03-18T14:08:48+04:00 HOST_NAME systemd[1]: Starting Synology Task Scheduler Vmtouch...
2023-03-18T14:09:14+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:14+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:09:15+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:16+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:09:16+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:09:16+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:17+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:09:17+04:00 HOST_NAME systemd[1]: Starting WebStation's service unit...
2023-03-18T14:09:18+04:00 HOST_NAME systemd[1]: Reloaded System Logger Daemon.
2023-03-18T14:09:18+04:00 HOST_NAME systemd[1]: Reloaded Synology SCGI.
2023-03-18T14:09:18+04:00 HOST_NAME systemd[1]: Reloaded Synology Cron Daemon.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloaded Synology Schedule Daemon.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Stopping Synology Task Scheduler Vmtouch...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started Synology Task Scheduler Vmtouch.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Starting Synology Task Scheduler Vmtouch...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started WebStation's service unit.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Starting WebStation PHP7.4 fpm process...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Starting WebStation fcgiWrap daemon...
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started WebStation PHP7.4 fpm process.
2023-03-18T14:09:19+04:00 HOST_NAME webstation_systemd_service_tool.sh[1504]: /usr/bin/mknod: /run/suphp_log: File exists
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Started WebStation fcgiWrap daemon.
2023-03-18T14:09:19+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:09:20+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:04+04:00 HOST_NAME systemd[1]: Reloaded WebStation PHP7.4 fpm process.
2023-03-18T14:10:04+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:10:04+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:10:05+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Starting rutorrent's service unit...
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:23+04:00 HOST_NAME systemd[1]: Reloaded WebStation PHP7.4 fpm process.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Starting WebStation PHP7.4 fpm process...
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Started WebStation PHP7.4 fpm process.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Reloaded Nginx.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Reloaded Synology Schedule Daemon.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Started rutorrent's service unit.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Reloading.
2023-03-18T14:10:24+04:00 HOST_NAME systemd[1]: Device sys-subsystem-net-devices-eth0.device appeared twice with different sysfs paths /sys/devices/pci0000:00/0000:00:13.2/0000:03:00.0/net/eth1 and /sys/devices/pci0000:00/0000:00:13.3/0000:04:00.0/net/eth0
2023-03-18T14:10:25+04:00 HOST_NAME systemd[1]: Stopping Synology Task Scheduler Vmtouch...
2023-03-18T14:10:25+04:00 HOST_NAME systemd[1]: Started Synology Task Scheduler Vmtouch.
2023-03-18T14:10:25+04:00 HOST_NAME systemd[1]: Starting Synology Task Scheduler Vmtouch...

/var/log/nginx/error_default.log

2023/03/18 14:09:15 [warn] 1015#1015: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1015#1015: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1022#1022: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1022#1022: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1029#1029: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1029#1029: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1033#1033: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1033#1033: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1038#1038: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:15 [warn] 1038#1038: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1165#1165: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1165#1165: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1167#1167: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1167#1167: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1169#1169: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [warn] 1169#1169: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:16 [notice] 1169#1169: signal process started
2023/03/18 14:09:18 [warn] 1411#1411: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:18 [warn] 1411#1411: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1420#1420: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1420#1420: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1431#1431: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1431#1431: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [notice] 1431#1431: signal process started
2023/03/18 14:09:19 [warn] 1451#1451: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1451#1451: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1460#1460: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1460#1460: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1467#1467: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [warn] 1467#1467: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:09:19 [notice] 1467#1467: signal process started
2023/03/18 14:10:03 [warn] 2625#2625: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:03 [warn] 2625#2625: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2650#2650: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2650#2650: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2663#2663: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2663#2663: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2680#2680: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2680#2680: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2683#2683: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [warn] 2683#2683: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:04 [notice] 2683#2683: signal process started
2023/03/18 14:10:23 [warn] 3334#3334: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:23 [warn] 3334#3334: low address bits of HOST_IP are meaningless in /var/tmp/nginx/test/plugin_config/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:23 [warn] 3343#3343: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:23 [warn] 3343#3343: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3351#3351: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3351#3351: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3361#3361: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [warn] 3361#3361: low address bits of HOST_IP are meaningless in /etc/nginx/conf.d/dsm.ssdp.conf:2
2023/03/18 14:10:24 [notice] 3361#3361: signal process started

/var/log/nginx/error.log

2023/03/18 14:11:21 [error] 3365#3365: *67757 connect() failed (111: Connection refused) while connecting to upstream, client: LAPTOP_IP, server: _, request: "GET /rutorrent/ HTTP/1.1", upstream: "http://127.0.0.1:915/rutorrent/", host: "HOST_IP", referrer: "http://HOST_IP:5000/"
2023/03/18 14:11:21 [error] 3365#3365: *67760 open() "/var/services/web/missing" failed (2: No such file or directory), client: LAPTOP_IP, server: , request: "GET /missing HTTP/1.1", host: "HOST_IP", referrer: "http://HOST_IP/rutorrent/"

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023 •
edited
Loading

Ok, something is weird in the /var/log/nginx/error.log

[error] 3365#3365: *67757 connect() failed (111: Connection refused) while connecting to upstream, client: LAPTOP_IP,
[error] 3365#3365: *67760 open() "/var/services/web/missing" failed (2: No such file or directory), client: LAPTOP_IP

It is using my laptop's IP address, see "client: LAPTOP_IP" (I removed the real IP)

So why is it pointing to my laptop's IP instead of my Synology IP (which in the log file is HOST_IP)?

Edit: Maybe because I am accessing a lot of web-ui on synology from my laptop.

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

Do you have apache 2.4 and php 7.4 installed/enabled (now in english)?

No, only NGINX and PHP 7.4 are installed. The rest is not.

@smaarn in the INFO file of rutorrent I see that this package depends on apache-web
Can you confirm that rutorrent does not run with nginx web server?
If that is confirmed, why does the package installer not complain about missing apache 2.4 package?

@hgy59
Copy link
Contributor

hgy59 commented Mar 18, 2023

@voidfel can you install apache 2.4 and try again?

@voidfel
Copy link
Author

voidfel commented Mar 18, 2023 •
edited
Loading

@voidfel can you install apache 2.4 and try again?

Installed Apache 2.4, uninstalled ruTorrent, installed ruTorrent, and it works now! Thanks!!

So it definitely needs Apache 2.4.

@smaarn
Copy link
Contributor

smaarn commented Mar 18, 2023

@hgy59 indeed we need to enforce this. I will try having a look at the possibility of supporting several backends and failing installation if none are present. At least it should be made mandatory indeed.

@mreid-tt
Copy link
Contributor

Regarding the package depends on apache-web issue, this was something I experienced while working on ownCloud. For my build, ownCloud was not going to work with nginx but the requirement INSTALL_DEP_SERVICES = apache-web does not work anymore. According to the developer guide that command worked up to DSM 5.2. To force the inclusion of apache you'd need to include as part of the SPK_DEPENDS.

I note that you have a WIP PR #5617 and if Apache is required, this line:

spksrc/spk/rutorrent/Makefile

Line 7 in 7820b1c

SPK_DEPENDS = "WebStation:python310:PHP7.4"

Needs to be:

SPK_DEPENDS = "WebStation:python310:PHP7.4:Apache2.4"

@smaarn smaarn mentioned this issue Mar 18, 2023
Merged
5 tasks
@smaarn
Copy link
Contributor

smaarn commented Mar 18, 2023

Created MR to fix the minimal dependency here: #5669

Unfortunately there is no way from what I recall to have a list of dependencies to say "at least one of those". Will try to check for DSM 7 integration if there is something I can do.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug
Projects
None yet
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

rutorrent: fix volume customization in installation procedure and package dependencies smaarn/spksrc
4 participants
@mreid-tt @smaarn @hgy59 @voidfel