nVidia Shield Pro operation not permitted

Channels DVR Server Troubleshooting
#1

Getting the following error on nVidia Shield Pro with OS version 9.1.1 (latest) and
CDVR version 2023.04.20.0310

2023/04/23 18:07:28.352210 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20230424.010728/recorder.db: operation not permitted
2023/04/23 18:07:29.687464 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20230424.010729/recorder.db: operation not permitted
2023/04/23 18:12:29.712719 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20230424.011229/recorder.db: operation not permitted

This backup runs every 5 minutes. The files and directories get created but never removed, and over time the number of files and directories will get into the tens of thousands forcing me to have to manually remove them.

This also happens to files in the Streaming directory

2023/04/23 15:57:48.709254 [M3U8] Generator: consecutive_errors=2580 err=can't close tempfile "/storage/DS1515/channels/Streaming/m3u8/1530/stream.m3u83665495747": close /storage/DS1515/channels/Streaming/m3u8/1530/stream.m3u83665495747: operation not permitted
2023/04/23 15:57:55.555841 [M3U8] Generator: consecutive_errors=2585 err=can't close tempfile "/storage/DS1515/channels/Streaming/m3u8/1530/stream.m3u81794270950": close /storage/DS1515/channels/Streaming/m3u8/1530/stream.m3u81794270950: operation not permitted
2023/04/23 15:58:02.311363 [M3U8] Generator: consecutive_errors=2590 err=can't close tempfile "/storage/DS1515/channels/Streaming/m3u8/1530/stream.m3u82082644455": close /storage/DS1515/channels/Streaming/m3u8/1530/stream.m3u82082644455: operation not permitted

Recordings can be created, read, and deleted just fine.

/storage/DS1515 an SMB file system mounted to a Synology NAS device running DSM version 7.1.1-42962 Update 5. It has been configured to support the SMB2 protocol only.

I've tried re-mounting the SMB device, clearing the CDVR app cache, and rebooting the Shield but the issue persists.

#2

It's a permissions issue, perhaps on the SMB settings on the NAS side. Or you're using a guest user or someone without permissions to login on the SHIELD client.

You could try a file explorer app to see if you can create files yourself on that share from the SHIELD.

#3

I'm using a named user, not guest. Permissions have been set to read write for this user on the NAS device. Recordings are created, read, and deleted just fine so I don't think it's a NAS/filesystem permissions issue.

#4

Is this a new install? Was it working before? When did it stop working?

#5

I've been using CDVR for a few years now. I've not seen this issue in the past. I just noticed it today when I was looking at the log file. Not sure when it started since the log doesn't go back that far.

#6

The only change I made recently was to upgrade the NAS from DSM 6 to DSM 7, but I don't understand why some files would be affected and not others. Seems like the error is coming from the Shield OS.

1 Like
#7

https://getchannels.com/docs/getting-started/faqs/subscription/#how-can-i-view-more-of-the-channels-dvr-server-log

How can I view more of the Channels DVR Server Log?

By default the Channels DVR Server log only shows the last 1500 lines. To see more of the log, change the url from

http://x.x.x.x:8089/admin/log

to

http://x.x.x.x:8089/log?n=10000

where x.x.x.x is the IP address of your Channels DVR Server and n=10000 is the number of lines to display

#8

We released a new version a couple days ago which may be the reason. When did you upgrade DSM?

#9

Possible fix in next prerelease build. There was a similar known issue when 9.0 first came out. We had a hack for it a while ago, I re-added in case it helps here.

But nothing has really changed on our side. Did you update the SHIELD OS recently? Have you tried rebooting?

1 Like
#10

Weird. I went back 200K lines and see this issue going as far back as 2022/11/06, but I still can't tell when it started. Is this log stored on the filesystem somewhere so that I can parse it using awk/grep/etc? I updated my NAS a week ago, so it's not that, and it's not due to the version you released a couple of days ago. Hmm.

#11

As you can tell, i don't look at the log very often, and I had to clean up a LOT of files today, after months of accumulation, lol.

#12

It's under /data/user/0/com.getchannels.dvr/files/channels-dvr/data/channels-dvr.log but I'm not sure you'll be able to access that directly.

curl http://x.x.x.x:8089/log?n=99999999999999 may be the best bet.

We removed the workaround around Sep 2022 so its possible it's been erroring since the 2022.09.14.2324 self update.

#13

I went back 300K lines and found exactly when it started happening

2022/09/14 17:21:05.568758 [SYS] Downloading new version v2022.09.14.2324
2022/09/14 17:21:12.730448 [SYS] Update downloaded and verified successfully.
2022/09/14 17:21:12.730490 [SYS] Shutting down for upgrade from v2022.08.08.2006 to v2022.09.14.2324
2022/09/14 17:21:12.732201 [SYS] Bonjour service stopped.
2022/09/14 17:21:12.737612 [DVR] Recording engine stopped.
2022/09/14 17:21:13.931320 [SYS] Starting Channels DVR v2022.09.14.2324 (android-arm64 pid:10771) in /data/user/0/com.getchannels.dvr/files/channels-dvr/data
2022/09/14 17:21:14.032172 [SYS] Started HTTP Server on 8089
2022/09/14 17:21:14.493326 [HDR] Found 1 devices
2022/09/14 17:21:15.334535 [M3U] Refreshed lineup for ... with 39 channels
2022/09/14 17:21:18.002731 [DVR] Recording engine started in /storage/DS1515/channels
2022/09/14 17:21:18.016545 [SYS] Bonjour service running for dvr-shield.local. [192.168.1.221]
2022/09/14 17:21:18.018113 [SYS] Removing old update 2021.10.25.1801
2022/09/14 17:21:24.097082 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20220914.172123/recorder.db: operation not permitted
2022/09/14 17:21:28.067309 [IDX] Pruned 678 expired airings from ... in 39.295365ms.
2022/09/14 17:21:28.106801 [IDX] Pruned 304 expired airings from ... in 39.309636ms.
2022/09/14 17:26:18.103075 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20220914.172618/recorder.db: operation not permitted
2022/09/14 17:31:18.139125 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20220914.173118/recorder.db: operation not permitted
2022/09/14 17:36:18.140845 [ERR] Could not create backup: close /storage/DS1515/channels/Database/backup-20220914.173618/recorder.db: operation not permitted

Prior to that it was running fine.

#14

Wow, you nailed the version exactly!

1 Like
#15

Great in that case a fix is coming shortly.

#16

Awesome. Thank you!

#17

Fix available:

#18

Wow, that was fast. Seems to be working...

2023/04/23 20:23:40.537750 [SYS] Downloading new version v2023.04.24.0239
2023/04/23 20:23:45.136269 [SYS] Update downloaded and verified successfully.
2023/04/23 20:23:45.611717 [SYS] Shutting down for upgrade from v2023.04.20.0310 to v2023.04.24.0239
2023/04/23 20:23:45.615261 [SYS] Bonjour service stopped.
2023/04/23 20:23:45.617217 [DVR] Recording engine stopped.
2023/04/23 20:23:54.526119 [SYS] Starting Channels DVR v2023.04.24.0239 (android-arm64 pid:8710) in /data/user/0/com.getchannels.dvr/files/channels-dvr/data
2023/04/23 20:23:54.536825 [SYS] Started HTTP Server on 8089
2023/04/23 20:23:54.993812 [HDR] Found 1 devices
2023/04/23 20:23:56.331541 [M3U] Refreshed lineup for AustraliaSydney with 92 channels
2023/04/23 20:23:57.352597 [DVR] Waiting 2h36m2.647417203s until next job 1682316000-20 Seattle Sports Live
2023/04/23 20:23:57.358845 [DVR] Recording engine started in /storage/DS1515/channels
2023/04/23 20:23:57.371976 [SYS] Bonjour service running for dvr-shield.local. [192.168.1.221]
2023/04/23 20:23:57.373571 [SYS] Removing old update 2022.11.15.1908
2023/04/23 20:23:57.563692 [SYS] Created database snapshot: backup-20230424.032357
2023/04/23 20:23:57.581186 [SYS] Removing old backup backup-20230423.180119
2023/04/23 20:23:58.582500 [SYS] Removing old backup backup-20230423.180320
2023/04/23 20:23:58.880579 [SYS] Removing old backup backup-20230423.180430
...
2023/04/23 20:24:23.301639 [SYS] Removing old backup backup-20230424.010410
2023/04/23 20:24:23.583171 [SYS] Removing old backup backup-20230424.010728

I'm not seeing those error messages anymore. Thank you!

1 Like
#19

This topic was automatically closed 365 days after the last reply. New replies are no longer allowed.