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.

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

SABnzbd 4.2.2 creates files with incorrect permissions (600 instead of 666) when using 7za to unpack #6009

Open
1 task done
JustAndreww opened this issue Feb 8, 2024 · 38 comments

Comments

@JustAndreww
Copy link

JustAndreww commented Feb 8, 2024

Is this a new Bug?

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

Package Name

SABnzbd

Package Version

4.2.2

Device Model

DS920+

Device Architecture

x86_64

Firmware Version

DSM 7.2.1-69057 Update 4

What happened?

When unpacking 7Z downloads resulted file will have 600 permissions instead of 666. So I can't open it in Windows in mounted network drive. Doesn't happen with RAR downloads.

Permissions are set as follows for the downloading folder:
image

Reproduction steps

Download some NZB with 7z inside. Unpack will finish OK, resulted file cannot be opened in the mounted Windows drive folder due to lack of access rights.
No errors or whatsoever in logs, everything seems to be fine.

Install Log

https://pastebin.com/dXQHvhaD

ls -l output

ash-4.4# ls -l 7z_download/
-rw------- 1 sc-sabnzbd synocommunity 827135139 Jan 31 09:31 7z.mkv
--
ash-4.4# ls -l rar_download/
-rw-rw-rw- 1 sc-sabnzbd synocommunity     304997 Feb  8 12:27 rar.jpg
-rw-rw-rw- 1 sc-sabnzbd synocommunity 3589946749 Feb  8 12:26 rar.mp4

Sabnzbd log with 7za arguments call

Log file
2024-02-08 18:13:10,205::INFO::[database:279] Added job XXXXX to history
2024-02-08 18:13:10,206::INFO::[postproc:138] Saving postproc queue
2024-02-08 18:13:10,206::DEBUG::[filesystem:1198] [sabnzbd.postproc.save] Saving data for postproc2.sab
2024-02-08 18:13:10,206::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for postproc2.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:13:10,206::INFO::[downloader:422] Post-processing finished, resuming download
2024-02-08 18:13:14,206::DEBUG::[articlecache:140] Saving 0 cached articles to disk
2024-02-08 18:13:14,206::INFO::[nzbqueue:230] Saving queue
2024-02-08 18:13:14,207::DEBUG::[filesystem:1198] [sabnzbd.nzbqueue.save] Saving data for queue10.sab
2024-02-08 18:13:14,207::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for queue10.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:13:14,207::DEBUG::[filesystem:1198] [sabnzbd.bpsmeter.save] Saving data for totals10.sab
2024-02-08 18:13:14,207::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for totals10.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:13:14,208::DEBUG::[filesystem:1198] [sabnzbd.dirscanner.save] Saving data for watched_data2.sab
2024-02-08 18:13:14,208::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for watched_data2.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:13:14,208::INFO::[postproc:138] Saving postproc queue
2024-02-08 18:13:14,208::DEBUG::[filesystem:1198] [sabnzbd.postproc.save] Saving data for postproc2.sab
2024-02-08 18:13:14,208::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for postproc2.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:13:14,208::DEBUG::[filesystem:1198] [sabnzbd.rss.save] Saving data for rss_data.sab
2024-02-08 18:13:14,208::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for rss_data.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:13:14,209::INFO::[notifier:142] Sending notification: SABnzbd - Queue finished (type=queue_done, job_cat=None)
2024-02-08 18:16:23,301::INFO::[nzbparser:87] Attempting to add XXXXX.nzb
2024-02-08 18:16:23,301::INFO::[nzbstuff:749] Replacing spaces with underscores in XXXXX
2024-02-08 18:16:23,301::INFO::[filesystem:746] Creating directories: /volume2/homes/silent/NZB/Incomplete/XXXXX
2024-02-08 18:16:23,301::INFO::[filesystem:746] Creating directories: /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,302::INFO::[filesystem:1239] Saving /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/XXXXX.nzb.gz
2024-02-08 18:16:23,304::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_qurh94x9 in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,304::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.001 added to queue
2024-02-08 18:16:23,305::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_hiq6zjdg in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,305::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.002 added to queue
2024-02-08 18:16:23,306::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_yy16jt4w in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,306::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.003 added to queue
2024-02-08 18:16:23,307::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_z2pn6q3k in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,307::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.004 added to queue
2024-02-08 18:16:23,307::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_o6b0d_0e in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,307::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.005 added to queue
2024-02-08 18:16:23,309::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_96un0tvu in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,309::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.006 added to queue
2024-02-08 18:16:23,309::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_88sr65bc in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,309::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.007 added to queue
2024-02-08 18:16:23,310::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_who8j1kt in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,310::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.008 added to queue
2024-02-08 18:16:23,311::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_e_e0o9ud in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,311::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.009 added to queue
2024-02-08 18:16:23,311::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_ju53sxbd in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,312::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.011 added to queue
2024-02-08 18:16:23,312::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_28newher in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,312::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.010 added to queue
2024-02-08 18:16:23,313::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_hmraeahy in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,313::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.012 added to queue
2024-02-08 18:16:23,314::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_br8vgg7b in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,314::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.013 added to queue
2024-02-08 18:16:23,314::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_i_l7_cn_ in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,314::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.014 added to queue
2024-02-08 18:16:23,316::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_2bt488nl in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,316::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.015 added to queue
2024-02-08 18:16:23,316::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_xow14oya in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,316::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.016 added to queue
2024-02-08 18:16:23,317::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_31ijrprw in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,317::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.017 added to queue
2024-02-08 18:16:23,317::INFO::[nzbstuff:961] File XXXXX.vol-01.par2 added to queue
2024-02-08 18:16:23,318::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_k7bc63zv in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,318::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.018 added to queue
2024-02-08 18:16:23,319::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_ki7zc7tc in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,319::INFO::[nzbstuff:961] File nODRrtI6XBqzq1ZyHAXY6W.7z.019 added to queue
2024-02-08 18:16:23,319::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_fc0191b8 in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,319::INFO::[nzbstuff:961] File XXXXX.vol-02.par2 added to queue
2024-02-08 18:16:23,320::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_x0ohh2p7 in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,320::INFO::[nzbstuff:961] File XXXXX.vol-03.par2 added to queue
2024-02-08 18:16:23,320::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_rms44rjy in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,320::INFO::[nzbstuff:961] File XXXXX.vol-04.par2 added to queue
2024-02-08 18:16:23,321::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.__init__] Saving data for SABnzbd_nzf_wzv_hwzm in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,321::INFO::[nzbstuff:961] File XXXXX.vol-05.par2 added to queue
2024-02-08 18:16:23,321::DEBUG::[misc:264] Parsing category * to attributes: pp=3 script=None prio=0
2024-02-08 18:16:23,321::DEBUG::[nzbstuff:931] NZB nzo-info = {}
2024-02-08 18:16:23,321::INFO::[nzbqueue:230] Saving queue
2024-02-08 18:16:23,321::DEBUG::[nzbstuff:1874] Saving attributes {'cat': '*', 'pp': 3, 'script': 'None', 'priority': 0, 'final_name': 'XXXXX', 'password': None, 'url': None} for XXXXX
2024-02-08 18:16:23,322::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.save_to_disk] Saving data for SABnzbd_nzo_ac964olv in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,322::DEBUG::[filesystem:1198] [sabnzbd.nzbqueue.save] Saving data for queue10.sab
2024-02-08 18:16:23,322::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for queue10.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:16:23,322::INFO::[notifier:142] Sending notification: NZB added to queue - XXXXX.nzb (type=download, job_cat=*)
2024-02-08 18:16:23,323::DEBUG::[filesystem:952] [sabnzbd.nzbparser.process_single_nzb] Deleting file /tmp/tmpp1sq_k8j.nzb
2024-02-08 18:16:23,323::DEBUG::[downloader:225] Retrieving server address information for news.newshosting.com
2024-02-08 18:16:23,323::DEBUG::[downloader:225] Retrieving server address information for eu.newsdemon.com
2024-02-08 18:16:23,323::DEBUG::[downloader:225] Retrieving server address information for eu.usenetprime.com
2024-02-08 18:16:23,428::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.001
2024-02-08 18:16:23,428::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_qurh94x9 from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_qurh94x9
2024-02-08 18:16:23,995::DEBUG::[deobfuscate_filenames:112] Checking: nODRrtI6XBqzq1ZyHAXY6W
2024-02-08 18:16:23,995::DEBUG::[deobfuscate_filenames:168] Obfuscated (default)
2024-02-08 18:16:23,995::DEBUG::[nzbstuff:1874] Saving attributes {'cat': '*', 'pp': 3, 'script': 'None', 'priority': 0, 'final_name': 'XXXXX', 'password': None, 'url': None} for XXXXX
2024-02-08 18:16:23,995::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-01.par2
2024-02-08 18:16:23,995::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-01.par2
2024-02-08 18:16:23,995::DEBUG::[filesystem:1130] [sabnzbd.nzbstuff.save_to_disk] Saving data for SABnzbd_nzo_ac964olv in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:16:23,996::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-01.par2
2024-02-08 18:16:23,996::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_xfk7tevr
2024-02-08 18:16:23,997::DEBUG::[filesystem:1198] [sabnzbd.bpsmeter.save] Saving data for totals10.sab
2024-02-08 18:16:23,997::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_xfk7tevr
2024-02-08 18:16:23,997::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for totals10.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:16:23,998::DEBUG::[par2file:175] Par2-creator of XXXXX.vol-01.par2 is: ParPar v0.4.3 x64 [https://animetosho.org/app/parpar]
2024-02-08 18:16:23,999::DEBUG::[nzbstuff:1059] Got par2pack for set XXXXX
2024-02-08 18:16:23,999::INFO::[nzbstuff:1765] Checking all filenames for XXXXX
2024-02-08 18:16:23,999::INFO::[nzbstuff:1768] Re-sorting XXXXX after getting filename information
2024-02-08 18:16:24,487::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:16:24,529::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:16:24,582::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:16:24,614::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:16:24,625::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:16:24,646::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:16:24,879::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:16:25,132::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:16:25,175::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:16:25,206::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:16:25,206::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_hiq6zjdg from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_hiq6zjdg
2024-02-08 18:16:25,249::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:16:25,512::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:16:26,976::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:16:26,977::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_yy16jt4w from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_yy16jt4w
2024-02-08 18:16:27,191::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:16:27,903::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:16:28,061::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:16:28,075::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:16:28,075::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:16:28,075::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_hiq6zjdg
2024-02-08 18:16:28,075::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_hiq6zjdg
2024-02-08 18:16:28,700::DEBUG::[bpsmeter:351] Speed: 22.7 MB/s
2024-02-08 18:16:28,836::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:16:28,836::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_z2pn6q3k from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_z2pn6q3k
2024-02-08 18:16:29,087::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:16:30,708::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:16:30,708::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_o6b0d_0e from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_o6b0d_0e
2024-02-08 18:16:30,709::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:16:30,722::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:16:30,723::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:16:30,723::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_yy16jt4w
2024-02-08 18:16:30,723::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_yy16jt4w
2024-02-08 18:16:31,713::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:16:32,433::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.006
2024-02-08 18:16:32,433::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_96un0tvu from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_96un0tvu
2024-02-08 18:16:32,977::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:16:33,710::DEBUG::[bpsmeter:351] Speed: 22.8 MB/s
2024-02-08 18:16:34,328::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:16:34,328::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_88sr65bc from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_88sr65bc
2024-02-08 18:16:34,402::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:16:34,414::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:16:34,414::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:16:34,414::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_z2pn6q3k
2024-02-08 18:16:34,415::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_z2pn6q3k
2024-02-08 18:16:34,695::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:16:34,707::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:16:34,707::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:16:34,707::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_o6b0d_0e
2024-02-08 18:16:34,707::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_o6b0d_0e
2024-02-08 18:16:36,154::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:16:36,155::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_who8j1kt from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_who8j1kt
2024-02-08 18:16:38,053::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:16:38,053::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_e_e0o9ud from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_e_e0o9ud
2024-02-08 18:16:38,170::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:16:38,183::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:16:38,183::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:16:38,183::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_88sr65bc
2024-02-08 18:16:38,183::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_88sr65bc
2024-02-08 18:16:38,712::DEBUG::[bpsmeter:351] Speed: 22.8 MB/s
2024-02-08 18:16:39,005::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:16:39,809::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:16:39,809::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_28newher from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_28newher
2024-02-08 18:16:41,714::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:16:41,714::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_ju53sxbd from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_ju53sxbd
2024-02-08 18:16:42,211::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006
2024-02-08 18:16:42,223::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006
2024-02-08 18:16:42,223::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006
2024-02-08 18:16:42,223::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_96un0tvu
2024-02-08 18:16:42,223::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_96un0tvu
2024-02-08 18:16:42,609::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
2024-02-08 18:16:42,621::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
2024-02-08 18:16:42,621::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
2024-02-08 18:16:42,621::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_qurh94x9
2024-02-08 18:16:42,621::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_qurh94x9
2024-02-08 18:16:42,849::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:16:42,861::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:16:42,861::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:16:42,861::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_who8j1kt
2024-02-08 18:16:42,861::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_who8j1kt
2024-02-08 18:16:43,162::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:16:43,176::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:16:43,176::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:16:43,176::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_28newher
2024-02-08 18:16:43,176::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_28newher
2024-02-08 18:16:43,475::DEBUG::[deobfuscate_filenames:112] Checking: nODRrtI6XBqzq1ZyHAXY6W.vol01+02
2024-02-08 18:16:43,475::DEBUG::[deobfuscate_filenames:149] Not obfuscated: upperchars >= 2 and lowerchars >= 2  and spacesdots >= 1
2024-02-08 18:16:43,475::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-02.par2
2024-02-08 18:16:43,507::DEBUG::[deobfuscate_filenames:112] Checking: nODRrtI6XBqzq1ZyHAXY6W.vol03+04
2024-02-08 18:16:43,507::DEBUG::[deobfuscate_filenames:149] Not obfuscated: upperchars >= 2 and lowerchars >= 2  and spacesdots >= 1
2024-02-08 18:16:43,507::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-03.par2
2024-02-08 18:16:43,528::DEBUG::[deobfuscate_filenames:112] Checking: nODRrtI6XBqzq1ZyHAXY6W.vol00+01
2024-02-08 18:16:43,528::DEBUG::[deobfuscate_filenames:149] Not obfuscated: upperchars >= 2 and lowerchars >= 2  and spacesdots >= 1
2024-02-08 18:16:43,529::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:16:43,529::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-04.par2
2024-02-08 18:16:43,529::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_hmraeahy from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_hmraeahy
2024-02-08 18:16:43,560::DEBUG::[deobfuscate_filenames:112] Checking: nODRrtI6XBqzq1ZyHAXY6W.vol07+07
2024-02-08 18:16:43,561::DEBUG::[deobfuscate_filenames:149] Not obfuscated: upperchars >= 2 and lowerchars >= 2  and spacesdots >= 1
2024-02-08 18:16:43,561::INFO::[nzbstuff:1765] Checking all filenames for XXXXX
2024-02-08 18:16:43,561::INFO::[nzbstuff:1768] Re-sorting XXXXX after getting filename information
2024-02-08 18:16:43,561::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-05.par2
2024-02-08 18:16:43,718::DEBUG::[bpsmeter:351] Speed: 22.8 MB/s
2024-02-08 18:16:44,813::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:16:44,826::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:16:44,826::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:16:44,827::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_e_e0o9ud
2024-02-08 18:16:44,827::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_e_e0o9ud
2024-02-08 18:16:45,397::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:16:45,398::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_br8vgg7b from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_br8vgg7b
2024-02-08 18:16:47,359::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:16:47,359::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_i_l7_cn_ from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_i_l7_cn_
2024-02-08 18:16:47,881::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:16:47,893::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:16:47,893::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:16:47,893::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_hmraeahy
2024-02-08 18:16:47,894::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_hmraeahy
2024-02-08 18:16:48,726::DEBUG::[bpsmeter:351] Speed: 22.7 MB/s
2024-02-08 18:16:48,925::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:16:48,938::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:16:48,939::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:16:48,939::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_ju53sxbd
2024-02-08 18:16:48,939::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_ju53sxbd
2024-02-08 18:16:49,175::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:16:49,176::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_2bt488nl from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_2bt488nl
2024-02-08 18:16:49,520::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:16:49,532::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:16:49,532::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:16:49,532::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_br8vgg7b
2024-02-08 18:16:49,532::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_br8vgg7b
2024-02-08 18:16:51,045::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:16:51,045::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_xow14oya from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_xow14oya
2024-02-08 18:16:51,619::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:16:51,631::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:16:51,631::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:16:51,631::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_i_l7_cn_
2024-02-08 18:16:51,632::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_i_l7_cn_
2024-02-08 18:16:52,870::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:16:52,871::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_31ijrprw from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_31ijrprw
2024-02-08 18:16:53,570::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:16:53,582::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:16:53,582::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:16:53,582::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_2bt488nl
2024-02-08 18:16:53,582::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_2bt488nl
2024-02-08 18:16:53,726::DEBUG::[bpsmeter:351] Speed: 22.7 MB/s
2024-02-08 18:16:54,738::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:16:54,739::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_k7bc63zv from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_k7bc63zv
2024-02-08 18:16:54,927::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:16:54,939::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:16:54,940::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:16:54,940::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_xow14oya
2024-02-08 18:16:54,940::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_xow14oya
2024-02-08 18:16:56,646::DEBUG::[nzbstuff:386] Finishing import on nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:16:56,646::DEBUG::[filesystem:1163] [sabnzbd.nzbstuff.finish_import] Loading data for SABnzbd_nzf_ki7zc7tc from /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_ki7zc7tc
2024-02-08 18:16:57,075::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:16:57,087::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:16:57,087::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:16:57,087::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_31ijrprw
2024-02-08 18:16:57,087::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_31ijrprw
2024-02-08 18:16:58,733::DEBUG::[bpsmeter:351] Speed: 22.7 MB/s
2024-02-08 18:16:59,100::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:16:59,111::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:16:59,111::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:16:59,111::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_k7bc63zv
2024-02-08 18:16:59,112::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_k7bc63zv
2024-02-08 18:16:59,571::INFO::[nzbqueue:768] [sabnzbd.nzbqueue.register_article] Ending job XXXXX
2024-02-08 18:16:59,571::DEBUG::[assembler:80] Decoding part of /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:16:59,580::DEBUG::[filesystem:650] Applying permissions 0o100666 (octal) to /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:16:59,580::INFO::[assembler:88] Decoding finished /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:16:59,580::DEBUG::[nzbstuff:460] Removing article database for SABnzbd_nzf_ki7zc7tc
2024-02-08 18:16:59,580::DEBUG::[filesystem:952] [sabnzbd.nzbstuff.remove_admin] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/SABnzbd_nzf_ki7zc7tc
2024-02-08 18:16:59,581::INFO::[nzbqueue:370] [sabnzbd.assembler.run] Removing job XXXXX
2024-02-08 18:16:59,581::INFO::[nzbqueue:230] Saving queue
2024-02-08 18:16:59,581::DEBUG::[filesystem:1198] [sabnzbd.nzbqueue.save] Saving data for queue10.sab
2024-02-08 18:16:59,581::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for queue10.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:16:59,581::INFO::[postproc:138] Saving postproc queue
2024-02-08 18:16:59,581::DEBUG::[filesystem:1198] [sabnzbd.postproc.save] Saving data for postproc2.sab
2024-02-08 18:16:59,581::DEBUG::[filesystem:1130] [sabnzbd.filesystem.save_admin] Saving data for postproc2.sab in /volume1/@appdata/sabnzbd/admin
2024-02-08 18:17:00,331::DEBUG::[nzbstuff:1874] Saving attributes {'cat': '*', 'pp': 3, 'script': 'None', 'priority': 0, 'final_name': 'XXXXX', 'password': None, 'url': None} for XXXXX
2024-02-08 18:17:00,331::INFO::[postproc:415] Starting Post-Processing on XXXXX => Repair:True, Unpack:True, Delete:True, Script:None, Cat:*
2024-02-08 18:17:00,331::INFO::[notifier:142] Sending notification: Post-processing - XXXXX (type=pp, job_cat=*)
2024-02-08 18:17:00,331::INFO::[postproc:779] Starting verification and repair of XXXXX
2024-02-08 18:17:00,331::INFO::[filesystem:1159] [sabnzbd.postproc.parring] /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__/__verified__ missing
2024-02-08 18:17:00,331::DEBUG::[postproc:785] Verified sets: {}
2024-02-08 18:17:00,331::INFO::[postproc:802] Running verification and repair on set XXXXX
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.001 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.002 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.003 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.004 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.005 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.006 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.007 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.008 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.009 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.010 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.011 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.012 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.013 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.014 OK
2024-02-08 18:17:00,332::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.015 OK
2024-02-08 18:17:00,333::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.016 OK
2024-02-08 18:17:00,333::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.017 OK
2024-02-08 18:17:00,333::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.018 OK
2024-02-08 18:17:00,333::DEBUG::[newsunpack:1889] Quick-check of file nODRrtI6XBqzq1ZyHAXY6W.7z.019 OK
2024-02-08 18:17:00,333::INFO::[newsunpack:1037] Quick-check for XXXXX is OK, skipping repair
2024-02-08 18:17:00,333::DEBUG::[filesystem:952] [sabnzbd.newsunpack.par2_repair] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-02.par2
2024-02-08 18:17:00,333::DEBUG::[filesystem:952] [sabnzbd.newsunpack.par2_repair] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-03.par2
2024-02-08 18:17:00,334::DEBUG::[filesystem:952] [sabnzbd.newsunpack.par2_repair] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-04.par2
2024-02-08 18:17:00,334::DEBUG::[filesystem:952] [sabnzbd.newsunpack.par2_repair] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-05.par2
2024-02-08 18:17:00,334::DEBUG::[filesystem:952] [sabnzbd.newsunpack.par2_repair] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/XXXXX.vol-01.par2
2024-02-08 18:17:00,334::DEBUG::[filesystem:541] build_filelists(): joinables: []
2024-02-08 18:17:00,334::DEBUG::[filesystem:542] build_filelists(): rars: []
2024-02-08 18:17:00,334::DEBUG::[filesystem:543] build_filelists(): 7zips: ['/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001']
2024-02-08 18:17:00,335::DEBUG::[filesystem:544] build_filelists(): ts: []
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:17:00,335::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:17:00,336::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:17:00,337::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:17:00,337::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006
2024-02-08 18:17:00,337::DEBUG::[postproc:996] No RAR-volume-number found in /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
2024-02-08 18:17:00,337::DEBUG::[postproc:998] Deobfuscate: rarvolnr is: {}
2024-02-08 18:17:00,337::DEBUG::[postproc:999] Deobfuscate: volnrext is: {}
2024-02-08 18:17:00,337::DEBUG::[postproc:857] Verified sets: {'XXXXX': True}
2024-02-08 18:17:00,337::DEBUG::[filesystem:1130] [sabnzbd.postproc.parring] Saving data for __verified__ in /volume2/homes/silent/NZB/Incomplete/XXXXX/__ADMIN__
2024-02-08 18:17:00,337::INFO::[postproc:860] Verification and repair finished for XXXXX
2024-02-08 18:17:00,337::INFO::[downloader:427] Forcing disconnect
2024-02-08 18:17:00,337::INFO::[filesystem:340] Checking if any resulting filenames need to be sanitized
2024-02-08 18:17:00,337::DEBUG::[downloader:941] Thread [email protected]: Forcing disconnect
2024-02-08 18:17:00,338::DEBUG::[sorting:171] No matching sorter found for job XXXXX
2024-02-08 18:17:00,338::INFO::[filesystem:746] Creating directories: /volume2/homes/silent/NZB/Complete/XXXXX
2024-02-08 18:17:00,339::DEBUG::[filesystem:916] Renaming "/volume2/homes/silent/NZB/Complete/XXXXX" to "/volume2/homes/silent/NZB/Complete/_UNPACK_XXXXX"
2024-02-08 18:17:00,339::INFO::[postproc:473] Running unpacker on XXXXX
2024-02-08 18:17:00,339::DEBUG::[filesystem:541] build_filelists(): joinables: []
2024-02-08 18:17:00,339::DEBUG::[filesystem:542] build_filelists(): rars: []
2024-02-08 18:17:00,340::DEBUG::[filesystem:543] build_filelists(): 7zips: ['/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001']
2024-02-08 18:17:00,340::DEBUG::[filesystem:544] build_filelists(): ts: []
2024-02-08 18:17:00,340::INFO::[newsunpack:319] 7za starting on /volume2/homes/silent/NZB/Incomplete/XXXXX
2024-02-08 18:17:00,340::INFO::[newsunpack:891] Starting extract on 7zip set/file: nODRrtI6XBqzq1ZyHAXY6W.7z 
2024-02-08 18:17:00,340::INFO::[misc:1232] [sabnzbd.newsunpack.seven_extract_core] Running external command: ['/volume1/@appstore/sabnzbd/bin/7za', 'x', '-y', '-aou', '-ssc', '-p', '-o/volume2/homes/silent/NZB/Complete/_UNPACK_XXXXX', '/volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001']
2024-02-08 18:17:00,340::DEBUG::[misc:1233] Popen arguments: {'stdout': -1, 'stderr': -2, 'bufsize': 0, 'startupinfo': None, 'creationflags': 0, 'text': True, 'encoding': 'utf8', 'errors': 'replace'}
2024-02-08 18:17:01,336::DEBUG::[newsunpack:972] 7za output: 
7-Zip (a) [64] 16.02 : Copyright (c) 1999-2016 Igor Pavlov : 2016-05-21
p7zip Version 16.02 (locale=en_US.UTF-8,Utf16=on,HugeFiles=on,64 bits,4 CPUs x64)

Scanning the drive for archives:
1 file, 44040192 bytes (42 MiB)

Extracting archive: /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
--
Path = /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
Type = Split
Physical Size = 44040192
Volumes = 19
Total Physical Size = 827135381
----
Path = nODRrtI6XBqzq1ZyHAXY6W.7z
Size = 827135381
--
Path = nODRrtI6XBqzq1ZyHAXY6W.7z
Type = 7z
Physical Size = 827135381
Headers Size = 242
Method = Copy
Solid = -
Blocks = 1

Everything is Ok

Size:       827135139
Compressed: 827135381

2024-02-08 18:17:01,337::INFO::[newsunpack:1001] Unpacked 1 files/folders in 0 seconds
2024-02-08 18:17:01,337::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.001
2024-02-08 18:17:01,342::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.002
2024-02-08 18:17:01,347::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.003
2024-02-08 18:17:01,348::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.004
2024-02-08 18:17:01,353::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.005
2024-02-08 18:17:01,358::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.006
2024-02-08 18:17:01,365::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.007
2024-02-08 18:17:01,370::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.008
2024-02-08 18:17:01,375::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.009
2024-02-08 18:17:01,375::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.010
2024-02-08 18:17:01,380::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.011
2024-02-08 18:17:01,385::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.012
2024-02-08 18:17:01,390::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.013
2024-02-08 18:17:01,395::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.014
2024-02-08 18:17:01,399::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.015
2024-02-08 18:17:01,405::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.016
2024-02-08 18:17:01,411::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.017
2024-02-08 18:17:01,416::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.018
2024-02-08 18:17:01,423::DEBUG::[filesystem:952] [sabnzbd.newsunpack.unseven] Deleting file /volume2/homes/silent/NZB/Incomplete/XXXXX/nODRrtI6XBqzq1ZyHAXY6W.7z.019
2024-02-08 18:17:01,423::INFO::[newsunpack:323] 7za finished on /volume2/homes/silent/NZB/Incomplete/XXXXX
2024-02-08 18:17:01,423::DEBUG::[filesystem:541] build_filelists(): joinables: []
2024-02-08 18:17:01,423::DEBUG::[filesystem:542] build_filelists(): rars: []
2024-02-08 18:17:01,423::DEBUG::[filesystem:543] build_filelists(): 7zips: []
2024-02-08 18:17:01,423::DEBUG::[filesystem:544] build_filelists(): ts: []
2024-02-08 18:17:01,423::INFO::[postproc:475] Unpacked files ['/volume2/homes/silent/NZB/Complete/_UNPACK_XXXXX/XXXXX.mkv']
2024-02-08 18:17:01,423::INFO::[filesystem:340] Checking if any resulting filenames need to be sanitized
2024-02-08 18:17:01,424::INFO::[postproc:479] Finished unpack_magic on XXXXX
2024-02-08 18:17:01,424::DEBUG::[filesystem:916] Renaming "/volume2/homes/silent/NZB/Complete/_UNPACK_XXXXX" to "/volume2/homes/silent/NZB/Complete/XXXXX"
2024-02-08 18:17:01,424::DEBUG::[filesystem:959] [sabnzbd.postproc.rename_and_collapse_folder] Removing dir /volume2/homes/silent/NZB/Complete/_UNPACK_XXXXX
2024-02-08 18:17:01,424::DEBUG::[deobfuscate_filenames:89] No additional par2 files found to process
2024-02-08 18:17:01,424::INFO::[postproc:573] Running deobfuscate
2024-02-08 18:17:01,424::DEBUG::[deobfuscate_filenames:248] Extension of /volume2/homes/silent/NZB/Complete/XXXXX/XXXXX.mkv looks common
2024-02-08 18:17:01,424::DEBUG::[deobfuscate_filenames:267] Trying to see if there are qualifying files to be deobfuscated
2024-02-08 18:17:01,424::DEBUG::[deobfuscate_filenames:281] Deobfuscate inspecting biggest file/volume2/homes/silent/NZB/Complete/XXXXX/XXXXX.mkv
2024-02-08 18:17:01,425::DEBUG::[deobfuscate_filenames:112] Checking: XXXXX
2024-02-08 18:17:01,425::DEBUG::[deobfuscate_filenames:149] Not obfuscated: upperchars >= 2 and lowerchars >= 2  and spacesdots >= 1
2024-02-08 18:17:01,425::DEBUG::[deobfuscate_filenames:289] /volume2/homes/silent/NZB/Complete/XXXXX/XXXXX.mkv excluded from deobfuscation because filename does not look obfuscated
2024-02-08 18:17:01,425::INFO::[nzbstuff:1806] [sabnzbd.postproc.process_job] Purging data for job XXXXX (delete_all_data=True)
2024-02-08 18:17:01,425::DEBUG::[articlecache:152] Purging 0 articles from the cache/disk
2024-02-08 18:17:01,425::DEBUG::[filesystem:985] Removing dir recursively /volume2/homes/silent/NZB/Incomplete/XXXXX
2024-02-08 18:17:01,425::INFO::[notifier:142] Sending notification: Download Completed - XXXXX (type=complete, job_cat=*)
@JustAndreww JustAndreww added the bug label Feb 8, 2024
@mreid-tt
Copy link
Contributor

mreid-tt commented Feb 8, 2024

@Safihre, could this maybe be an upstream issue?

@JustAndreww, can you indicate if this unpack function had the correct permissions in previous versions? It would be helpful in understanding if there was a specific version where it did work correctly.

@JustAndreww
Copy link
Author

I would love to, but I have only recently installed Sabnzbd and never used it before, so I can't really compare.

@JustAndreww JustAndreww changed the title SABnzbd 4.2.2 when using 7za to unpack creates files with incorrect permissions (600 instead of 666) SABnzbd 4.2.2 creates files with incorrect permissions (600 instead of 666) when using 7za to unpack Feb 8, 2024
@Safihre
Copy link
Contributor

Safihre commented Feb 9, 2024

Is is a bug in p7zip. Unfortunately the version used by SynoCommunity is 16.02, where the 16 stands for 2016.
p7zip hasn't been updated since.
We could just try to compile the official 7zip (without the "p"), since it has good Unix support now.
I'm just not that good in all the compile magic so I didn't dare to do so yet...

@JustAndreww
Copy link
Author

JustAndreww commented Feb 9, 2024

Just used pre-compiled x86_64 linux binary from 7zip website (7zzs) - replaced local 7za from /var/packages/sabnzbd/target/bin/7za, but still permissions are wrong after unpacking.


ash-4.4# 7za

7-Zip (z) 24.00 (x64) : Copyright (c) 1999-2024 Igor Pavlov : 2024-01-30
 64-bit locale=en_US.utf8 Threads:4 OPEN_MAX:1024, ASM

ash-4.4# ls -l 7za
-rwxr-xr-x 1 sc-sabnzbd synocommunity 3722360 Jan 30 18:57 7za

Maybe some additional arguments needs to be passed to popen from sabnzbd?

Also I think this issue would be quite easy to fix with post-unpack-script that will simply do chmod 666 to all the content in the unpacking directory, but I don't know how to write that kind of scripts :(

@Safihre
Copy link
Contributor

Safihre commented Feb 9, 2024

SABnzbd can do that (Config > Folders (enable Advanced Settings) > Permissions), however, this breaks Synology persmission system so that's why it's disabled by default.

If you can find which command line argument it is, I can always add it.

@JustAndreww
Copy link
Author

Thank you for the hint!

I will stick to that solution at the moment. 755 permissions looks OK to my use-case and as a temporary workaround.

@th0ma7
Copy link
Contributor

th0ma7 commented Feb 9, 2024

Is is a bug in p7zip. Unfortunately the version used by SynoCommunity is 16.02, where the 16 stands for 2016.
p7zip hasn't been updated since.
We could just try to compile the official 7zip (without the "p"), since it has good Unix support now.
I'm just not that good in all the compile magic so I didn't dare to do so yet...

I can have a look at that in the coming days if it helps.

@Safihre
Copy link
Contributor

Safihre commented Feb 10, 2024

Unfortunately it seems the new one also doesn't have any special flags (like unrar) to not set permissions..

@BenjV
Copy link

BenjV commented Feb 10, 2024

As far as I know does 7zip not set any permission at all.
So the file will get the default permission of the process running Sabnzbd depending on where the file is put.

If you need other permissions then you should make sure the location of the file is on a "shared folder" and the "system internal user" that sabnzbd is using must have read/write access there.

And the user from your Windows client should also have permissions there to be able to access them..

@Safihre
Copy link
Contributor

Safihre commented Feb 10, 2024

@BenjV this is not true for 7zip.
Just use this test nzb. It's a zip, which will use 7zip to unpack.
https://github.com/sabnzbd/sabnzbd.github.io/blob/master/tests/test_zip.nzb

@BenjV
Copy link

BenjV commented Feb 12, 2024

You can only test this on a Synology and with SabNzbd, any other test will be useless.

Within a zip there is no permission information so 7zip cannot set any meaninfull permissions.
So the permission the files get depend on the system setting where 7zip is running.

And on a Synology that will only result in a workable way if you put that files on a location where another user can access them as I explained.

@Safihre
Copy link
Contributor

Safihre commented Feb 12, 2024

@BenjV seriously, did you test it on your Synology? Because it does not work.
Show us a screenshot of the permissions that you get for a zip file downloaded and extracted with SABnzbd.
It seems 7zip sets permissions anyway.

@mreid-tt
Copy link
Contributor

@Safihre, I've done a few tests with the test nzb you provided. It normally downloads and extracts to downloads/complete/test_zip, with permissions like these:

$ ls -all
total 4380
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      24 Feb 12 08:22 .
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      20 Feb 12 08:22 ..
-rw-------  1 sc-sabnzbd synocommunity 4482652 Nov 18  2016 test_zip.bin

If I download only I get the folder with a file 8288838_ZIP_FILE.zip in it. Taking a look at the details, it looks like a fairly simple archive:

$ 7za l -slt 8288838_ZIP_FILE.zip 

7-Zip (a) [64] 16.02 : Copyright (c) 1999-2016 Igor Pavlov : 2016-05-21
p7zip Version 16.02 (locale=en_US.utf8,Utf16=on,HugeFiles=on,64 bits,2 CPUs x64)

Scanning the drive for archives:
1 file, 3624126 bytes (3540 KiB)

Listing archive: 8288838_ZIP_FILE.zip

--
Path = 8288838_ZIP_FILE.zip
Type = zip
Physical Size = 3624126

----------
Path = testfile.bin
Folder = -
Size = 4482652
Packed Size = 3623968
Modified = 2016-11-18 11:00:48
Created = 2017-03-15 08:26:47
Accessed = 2017-03-15 08:26:47
Attributes = AC
Encrypted = -
Comment = 
CRC = DC714B31
Method = Deflate
Host OS = FAT
Version = 20
Volume Index = 0

A manual extraction looks like this:

$ sudo -u sc-sabnzbd 7za x 8288838_ZIP_FILE.zip

7-Zip (a) [64] 16.02 : Copyright (c) 1999-2016 Igor Pavlov : 2016-05-21
p7zip Version 16.02 (locale=en_US.utf8,Utf16=on,HugeFiles=on,64 bits,2 CPUs x64)

Scanning the drive for archives:
1 file, 3624126 bytes (3540 KiB)

Extracting archive: 8288838_ZIP_FILE.zip
--
Path = 8288838_ZIP_FILE.zip
Type = zip
Physical Size = 3624126

Everything is Ok

Size:       4482652
Compressed: 3624126
$ ls -all
total 7920
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      64 Feb 12 08:14 .
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      20 Feb 12 07:54 ..
-rw-rw-rw-  1 sc-sabnzbd synocommunity 3624126 Feb 12 07:54 8288838_ZIP_FILE.zip
-rwx------  1 sc-sabnzbd synocommunity 4482652 Nov 18  2016 testfile.bin

As you can see the permissions are defaulting to the running user only. I can however override this forcibly like this:

$ sudo -u sc-sabnzbd sh -c 'umask 111 && 7za x 8288838_ZIP_FILE.zip'

7-Zip (a) [64] 16.02 : Copyright (c) 1999-2016 Igor Pavlov : 2016-05-21
p7zip Version 16.02 (locale=en_US.utf8,Utf16=on,HugeFiles=on,64 bits,2 CPUs x64)

Scanning the drive for archives:
1 file, 3624126 bytes (3540 KiB)

Extracting archive: 8288838_ZIP_FILE.zip
--
Path = 8288838_ZIP_FILE.zip
Type = zip
Physical Size = 3624126

Everything is Ok

Size:       4482652
Compressed: 3624126
$ ls -all
total 7920
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      64 Feb 12 08:20 .
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      20 Feb 12 07:54 ..
-rw-rw-rw-  1 sc-sabnzbd synocommunity 3624126 Feb 12 07:54 8288838_ZIP_FILE.zip
-rw-rw-rw-  1 sc-sabnzbd synocommunity 4482652 Nov 18  2016 testfile.bin

It's not the best method but I couldn't see any permissions setting options for 7za on first glance.

@th0ma7
Copy link
Contributor

th0ma7 commented Feb 12, 2024

Permissions would then follow the umask directive from the user shell environment...

@Safihre
Copy link
Contributor

Safihre commented Feb 12, 2024

So how would we choose the umask?

@mreid-tt
Copy link
Contributor

mreid-tt commented Feb 12, 2024

In my opinion, if 7za can't set permissions directly through arguments, it's more practical to use existing post-download methods. Introducing another workaround (like umask) doesn't seem necessary to me.

@Safihre
Copy link
Contributor

Safihre commented Feb 12, 2024

I thought so indeed.. Too bad 7zip doesn't have a parameter for it. Unrar does have a specific parameter to not set permissions (which we use).

@mreid-tt
Copy link
Contributor

mreid-tt commented Feb 12, 2024

@Safihre, based on my understanding, it seems that this issue is not exclusive to Synology but rather could potentially affect any Linux implementation. Would you concur with this assessment? If so, it implies that the problem lies upstream but is not inherently a flaw within SABnzbd itself. It is due to a dependency constraint preventing a straightforward resolution, though there exists a workaround to mitigate the issue. Would you agree with this interpretation?

@Safihre
Copy link
Contributor

Safihre commented Feb 12, 2024

Agreed. Not Synology specific. The complicating factor here is that if Permissions is set in SABnzbd Config Folders, it uses chmod and breaks the Synology permissions. But that's all we can do about it.

@mreid-tt
Copy link
Contributor

mreid-tt commented Feb 12, 2024

From Wikipedia on 7z:

The 7z format does not store filesystem permissions (such as UNIX owner/group permissions or NTFS ACLs), and hence can be inappropriate for backup/archival purposes.

@th0ma7
Copy link
Contributor

th0ma7 commented Feb 13, 2024

So how would we choose the umask?

umask is rather interesting... consider the following on my linux, default behavior:

$ touch test
$ ls -la test
-rw-rw-r-- 1 th0ma7 th0ma7 0 fév 12 21:39 test

Mode is u+rw, g+rw, a+r which would be described as 0664 with chmod command using octal mode. Likewise setting it rwx to all would be:

$ chmod 0777 test
$ ls -al test
-rwxrwxrwx 1 th0ma7 th0ma7 0 fév 12 21:39 test

Now what about umask you ask... well umask runs in octal mode where you mask certain bits. For instance, a normal u+rw, g+rw, a+r ,described as 0664, would mean having a umask of 0113 such as:

  0777
- 0664
--------
  0113

So using this principle:

$ umask 0113   <-- equivalent of chmod 0664, or considering 0777-0664 = 0113
$ rm test
$ touch test
$ ls -la test
-rw-rw-r-- 1 th0ma7 th0ma7 0 fév 12 21:42 test

umask sets the file creation mode of, well, files to be created by said program for which its environment was set with a certain umask. Now wanting files to be rw to all would be:

$ umask 0111   <-- equivalent of chmod 0666, or considering 0777-0666 = 0111
$ rm test
$ touch test
$ ls -la test
-rw-rw-rw- 1 th0ma7 th0ma7 0 fév 12 21:42 test

and so on...

Now, going back to sabnzbd, adding a simple umask 0113 (for 0664) or umask 0111 (for 0666) in the startup script may resolve the issue. Again, this may have a different behavior when used in conjunction with ACL ... but worth testing.

@BenjV
Copy link

BenjV commented Feb 13, 2024

You are all forgetting that Synology has implemented its own permission system based on the ACL's and not on the default Linux permissions.

@Safihre
Copy link
Contributor

Safihre commented Feb 13, 2024

We are very well aware.
So what do you propose we do @BenjV?

@BenjV
Copy link

BenjV commented Feb 13, 2024

I already explained it.

The target where 7zip will place the files must be on a "shared folder" and that shared folder must be granted read/write privs for the "system internal user" which is running 7zip so in the case 7zip is spawned by SabNzbd the system intenal user of SabNzbd.

And if you need access to those files by a user from the network, that user must be granted privs also.
And all this granting must be done via the DSM gui otherwise it will not function correctly.

@mreid-tt
Copy link
Contributor

mreid-tt commented Feb 13, 2024

@BenjV, isn't that the same advice we already provide in the Permission Management wiki? If so, then there is nothing to address in the package or the upstream software. If not, then I am unclear on how that addresses the issue raised by the user.

@Safihre
Copy link
Contributor

Safihre commented Feb 13, 2024

@BenjV Do you really not read anything posted by other users here?
@mreid-tt showed that 7zip forcedly sets permissions, so it's an upstream problem of 7zip that always sets permissions and breaks the usual DSM permission system.

@th0ma7
Copy link
Contributor

th0ma7 commented Feb 13, 2024

And if i may add, i played with 7zip to replace p7zip and wow ... Cross-compiling this isn't easy. I wasn't able to get far, even following arch linux recipe.

@mreid-tt
Copy link
Contributor

Now, going back to sabnzbd, adding a simple umask 0113 (for 0664) or umask 0111 (for 0666) in the startup script may resolve the issue. Again, this may have a different behavior when used in conjunction with ACL ... but worth testing.

hey @th0ma7, interesting findings. When you mean the startup script do you mean a modification to this line?

SERVICE_COMMAND="${LANGUAGE} ${PYTHON} -OO ${SABNZBD} -f ${CFG_FILE} --pidfile ${PID_FILE} -d"

@th0ma7
Copy link
Contributor

th0ma7 commented Feb 13, 2024

Yes. But testing is needed considering both acl and how p7zip works.

@Safihre
Copy link
Contributor

Safihre commented Feb 13, 2024

Considering this is the first report of this problem even though the problem has existed for years, should we really be adding that?

@mreid-tt
Copy link
Contributor

Sorry, I wasn't advocating a proposed change, I stand by my original recommendation that this is well handled by the existing post-processing. I was just clarifying in case I wanted to do some private testing (no commitment to so do).

@BenjV
Copy link

BenjV commented Feb 14, 2024

@BenjV Do you really not read anything posted by other users here? @mreid-tt showed that 7zip forcedly sets permissions, so it's an upstream problem of 7zip that always sets permissions and breaks the usual DSM permission system.

I could say the same of you.
The point is not to test this kind of thing on the command line because DSM is using ACL's and not the standard linux permission system.
So the permissions DSM is acting on, is depending on where the files are put by which user.
That is also the reason no package should set permissions by itself, that would mess-up things.

And as @mreid-tt said, this is already explained in the wiki.

If 7zip actualy sets the permission itself and by that messes-up the DSM permissions it can only be fixed upstreams, but I very much doubt that this is the case.
A normal application does not do anything with permissions but will leave that to the permission of the user who is running the application.

@Safihre
Copy link
Contributor

Safihre commented Feb 14, 2024

If 7zip actualy sets the permission itself and by that messes-up the DSM permissions it can only be fixed upstreams, but I very much doubt that this is the case. A normal application does not do anything with permissions but will leave that to the permission of the user who is running the application.

What more proof do you need that 7zip sets permissions?
We see it happen on the command line and when the process is spawned by SABnzbd.

@BenjV
Copy link

BenjV commented Feb 14, 2024

Did you read the results of the test @mreid-tt did?????
From his post:

As you can see the permissions are defaulting to the running user only.

This is proof that 7zip does not set the permissions on a zip file just like a rar file.

What maybe is happening is that the zip file contatins ntfs permissions and 7zip support this.
If that command switch is used (-sni), then that could explain the different outcome between rar files and zip files.

The process is:

  • 7zip creates a file.
  • The permissions of the file are set during file creation and are depending on the user and the location (as per DSM specs with ACL+).
  • Then 7zip tries to change the permissions to the ntfs permission in the zip, this will result in removing the ACL+ permissions

@mreid-tt
Copy link
Contributor

Folks, let's dial it back a bit. Both of you raise valid points, but I propose that instead of further speculation, we invest our time in conducting actual tests to validate our hypotheses. Here are a few points to consider:

@Safihre, as far as I can tell, 7zip does not set permissions for the archive in question. If this were the case the umask would not work as 7zip would override this environment setting.

@BenjV, the zip file in question does not contain any relevant NTFS permissions given the attributes that are set in the file were (as stated above):

Attributes = AC

Based on my observations, the attributes "archived and compressed" do not have any bearing on user permissions. Additionally, I tested using the -sni switch, but it did not alter the behaviour of the extracted file.

I am skeptical that permissions are solely inherited from the user and location. For instance, the parent folder of the zip file, created by 7zip, does not share the same permissions as its containing folder, as illustrated previously. My suspicion is that inheritance might be overridden, resulting in the absence of ACL+ attributes.

Before delving deeper into this discussion, I urge you to replicate the test I conducted and examine the folder permissions along with the ACL+ attributes. Further discourse without concrete evidence would be speculative.

@BenjV
Copy link

BenjV commented Feb 14, 2024

It probably only happens when the zip file contains ntfs permissions so the zip has to be created on a Windows system also with the -sni argument.
This is the only explaination I can think of regarding the difference between a rar file and a zip file.

When I find time (tomorrow maybe) I will perform some test.

@BenjV
Copy link

BenjV commented Feb 15, 2024

Tested with a file containing ntfs permissions but on the Nas 7zip could not extract such a file, so that is not the problem.

@mreid-tt
Copy link
Contributor

hey @Safihre, a bit off topic but I was testing a recent download of an NZB file which contained a RAR archive and I was surprised to find the extracted files with the following permissions:

drwxrwxrwx+ 1 sc-sabnzbd synocommunity     1572 Apr 17 09:04  .
drwxrwxrwx+ 1 sc-sabnzbd synocommunity       94 Apr 17 09:04  ..
-rw-------  1 sc-sabnzbd synocommunity      697 Apr 15 12:02  00-sam_smith-love_goes-web-2020.m3u
-rw-------  1 sc-sabnzbd synocommunity     8962 Apr 15 12:02  00-sam_smith-love_goes-web-2020.nfo
-rw-------  1 sc-sabnzbd synocommunity  6126566 Apr 15 12:02  01-sam_smith-young.mp3
-rw-------  1 sc-sabnzbd synocommunity  8560139 Apr 15 12:02  02-sam_smith-diamonds.mp3
[---snip---]

There were no ACLs set by default as this command shows:

synoacltool -get 02-sam_smith-diamonds.mp3 
(synoacltool.c, 596)It's Linux mode

Digging further I realised that while it was a RAR archive, on extraction it had another layer which was a ZIP file as shown below:

Archive: RT91vsW5g1zzV2yu0dUcPzAJAw1Hy.part01.rar
Details: RAR 5, volume 1

 Attributes      Size     Date    Time   Name
----------- ---------  ---------- -----  ----
 -rw-rw-rw- 135780369  2024-04-15 12:02  0dRErHHXynYen6GVBaM.zip
----------- ---------  ---------- -----  ----
            135780369                    1

As such, when the files were extracted with 7za the same lack of permissions setting took place. Given that the files don't actually have any ACLs set I don't really believe that setting the permissions on completed downloads is an actual issue. Setting it to '777', the newly extracted directory contains:

drwxrwxrwx  1 sc-sabnzbd synocommunity     1572 Apr 17 09:33  .
drwxrwxrwx+ 1 sc-sabnzbd synocommunity      168 Apr 17 09:33  ..
-rw-rw-rw-  1 sc-sabnzbd synocommunity      697 Apr 15 12:02  00-sam_smith-love_goes-web-2020.m3u
-rw-rw-rw-  1 sc-sabnzbd synocommunity     8962 Apr 15 12:02  00-sam_smith-love_goes-web-2020.nfo
-rw-rw-rw-  1 sc-sabnzbd synocommunity  6126566 Apr 15 12:02  01-sam_smith-young.mp3
-rw-rw-rw-  1 sc-sabnzbd synocommunity  8560139 Apr 15 12:02  02-sam_smith-diamonds.mp3
[---snip---]

The ACL details are the same:

synoacltool -get 02-sam_smith-diamonds.mp3 
(synoacltool.c, 596)It's Linux mode

I believe this is a reasonable workaround which doesn't seem to cause any issues on Synology as far as I can see.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

No branches or pull requests

5 participants