DVR panic

#1

@tmm1 / @maddox

Getting the following when tuning TVE channels on 2022.01.15.1918:

2022/01/15 20:01:22 [Recovery] 2022/01/15 - 20:01:22 panic recovered:
runtime error: invalid memory address or nil pointer dereference
runtime/panic.go:221 (0x44d206)
runtime/signal_unix.go:735 (0x44d1d6)
github.com/grafov/[email protected]/sink.go:305 (0x7d4db8)
github.com/fancybits/channels-server/tuner/stream.go:198 (0x80429d)
github.com/fancybits/channels-server/tuner/stream.go:88 (0x8027a4)
github.com/fancybits/channels-server/http_device.go:442 (0x1316d75)
github.com/gin-gonic/[email protected]/context.go:165 (0x12f9bb8)
github.com/fancybits/channels-server/http_device.go:41 (0x12f9aec)
github.com/gin-gonic/[email protected]/context.go:165 (0x12f6a4b)
github.com/fancybits/channels-server/http.go:235 (0x12f67b7)
github.com/gin-gonic/[email protected]/context.go:165 (0x12f672a)
github.com/fancybits/channels-server/http.go:215 (0x12f670f)
github.com/gin-gonic/[email protected]/context.go:165 (0x12f6591)
github.com/fancybits/channels-server/http.go:207 (0x12f5dbd)
github.com/gin-gonic/[email protected]/context.go:165 (0x9c0241)
github.com/gin-gonic/[email protected]/recovery.go:106 (0x9c022c)
github.com/gin-gonic/[email protected]/context.go:165 (0x9bf4a6)
github.com/gin-gonic/[email protected]/logger.go:241 (0x9bf489)
github.com/gin-gonic/[email protected]/context.go:165 (0x12a878c)
github.com/gin-contrib/[email protected]/sessions.go:65 (0x12a8778)
github.com/gin-gonic/[email protected]/context.go:165 (0x130f881)
github.com/fancybits/channels-server/http.go:277 (0x130f86b)
github.com/gin-gonic/[email protected]/context.go:165 (0x9be9dd)
github.com/gin-gonic/[email protected]/gin.go:420 (0x9be665)
github.com/gin-gonic/[email protected]/gin.go:376 (0x9be1c4)
net/http/server.go:2879 (0x6cf5da)
net/http/server.go:1930 (0x6cac87)
runtime/asm_amd64.s:1581 (0x46a720)

The client reports Tuner Not Available

#2

Fix in next build

#3

Still occurring in 2022.01.16.0302.


    2022/01/15 22:23:34.661283 [SYS] Downloading new version v2022.01.16.0302
2022/01/15 22:23:42.810846 [SYS] Update downloaded and verified successfully.
2022/01/15 22:23:42.810874 [SYS] Shutting down for upgrade from v2022.01.15.1918 to v2022.01.16.0302
2022/01/15 22:23:42.811167 [SYS] Bonjour service stopped.
2022/01/15 22:23:42.936040 [DVR] Recording engine stopped.
2022/01/15 22:23:43.940204 [SYS] Goodbye.
2022/01/15 22:23:44.583979 [SYS] Starting Channels DVR v2022.01.16.0302 (darwin-arm64 pid:7006) in /Users/chris/Library/Application Support/ChannelsDVR/data
2022/01/15 22:23:44.607752 [SYS] Started HTTP Server
2022/01/15 22:23:52.285716 [HDR] Found 0 devices
2022/01/15 22:23:52.564634 [TVE] action=cbs_station err=Post "https://www.cbs.com/live-tv/check-availability/": dial tcp 50.7.168.108:443: connect: connection refused
2022/01/15 22:23:52.746943 [TVE] action=cbs_station err=Post "https://www.cbs.com/live-tv/check-availability/": dial tcp 50.7.168.108:443: connect: connection refused
2022/01/15 22:23:52.928740 [TVE] action=cbs_station err=Post "https://www.cbs.com/live-tv/check-availability/": dial tcp 50.7.168.108:443: connect: connection refused
2022/01/15 22:23:53.004835 http: TLS handshake error from 192.168.4.85:53268: EOF
2022/01/15 22:23:54.054695 [DVR] Recording engine started in /Volumes/DVR/DVR


2022/01/15 22:24:23 [Recovery] 2022/01/15 - 22:24:23 panic recovered:
runtime error: invalid memory address or nil pointer dereference
runtime/panic.go:221 (0x102294117)
runtime/signal_unix.go:735 (0x1022af60b)
github.com/grafov/[email protected]/sink.go:305 (0x1025faec0)
github.com/fancybits/channels-server/tuner/stream.go:199 (0x10262a893)
github.com/fancybits/channels-server/tuner/stream.go:89 (0x102628eaf)
github.com/fancybits/channels-server/http_device.go:442 (0x103136677)
github.com/gin-gonic/[email protected]/context.go:165 (0x103111e1f)
github.com/fancybits/channels-server/http_device.go:41 (0x103111d24)
github.com/gin-gonic/[email protected]/context.go:165 (0x10310e64f)
github.com/fancybits/channels-server/http.go:235 (0x10310e328)
github.com/gin-gonic/[email protected]/context.go:165 (0x10310e29f)
github.com/fancybits/channels-server/http.go:215 (0x10310e278)
github.com/gin-gonic/[email protected]/context.go:165 (0x10310e0eb)
github.com/fancybits/channels-server/http.go:207 (0x10310d7e8)
github.com/gin-gonic/[email protected]/context.go:165 (0x1027f71af)
github.com/gin-gonic/[email protected]/recovery.go:106 (0x1027f718c)
github.com/gin-gonic/[email protected]/context.go:165 (0x1027f6497)
github.com/gin-gonic/[email protected]/logger.go:241 (0x1027f645c)
github.com/gin-gonic/[email protected]/context.go:165 (0x1030674e7)
github.com/gin-contrib/[email protected]/sessions.go:65 (0x1030674c4)
github.com/gin-gonic/[email protected]/context.go:165 (0x10312e137)
github.com/fancybits/channels-server/http.go:277 (0x10312e114)
github.com/gin-gonic/[email protected]/context.go:165 (0x1027f59c7)
github.com/gin-gonic/[email protected]/gin.go:420 (0x1027f5688)
github.com/gin-gonic/[email protected]/gin.go:376 (0x1027f529f)
net/http/server.go:2879 (0x102512e83)
net/http/server.go:1930 (0x10250e7cb)
runtime/asm_arm64.s:1133 (0x1022cd0e3)
#4

Fixed in v2022.01.16.0341

1 Like
#5

Thanks! This seems to have fixed the issue w/ Spectrum after deleting it and re-adding it as a source.

1 Like
#6

Just saw this in my beta 2022-01-27 0906 DVR log:

2022/01/30 12:01:00.641708 [DVR] Waiting 1h57m59.358303s until next job 1643576340-611 Matter of Fact With Soledad O'Brien
2022/01/30 12:01:00.745891 [DVR] Waiting 1h57m59.25412s until next job 1643576340-611 Matter of Fact With Soledad O'Brien
2022/01/30 12:01:04.383732 [DVR] Processing file-39730: TV/America's Dairyland at the Crossroads/America's Dairyland at the Crossroads 2021-11-18 2022-01-30-1059.mpg
2022/01/30 12:01:04.742181 [DVR] Processing file-39729: TV/SOS How to Survive/SOS How to Survive S02E05 2018-08-12 Grand Canyon Blizzard 2022-01-30-1057.mpg
2022/01/30 12:28:19.319905 [SYS] Created database snapshot: backup-20220130.122818
2022/01/30 12:28:19.320639 [SYS] Removing old backup backup-20220110.100515

2022/01/30 12:55:48 [Recovery] 2022/01/30 - 12:55:48 panic recovered:
runtime error: slice bounds out of range [:-2]
runtime/panic.go:108 (0x4034a34)
github.com/fancybits/channels-server/dvr/search.go:332 (0x4de13e4)
github.com/fancybits/channels-server/http_dvr_guide.go:123 (0x4f1ad24)
github.com/gin-gonic/[email protected]/context.go:169 (0x4edd44b)
github.com/fancybits/channels-server/http.go:240 (0x4edd1b7)
github.com/gin-gonic/[email protected]/context.go:169 (0x4edd12a)
github.com/fancybits/channels-server/http.go:220 (0x4edd10f)
github.com/gin-gonic/[email protected]/context.go:169 (0x4edcf91)
github.com/fancybits/channels-server/http.go:212 (0x4edc7a9)
github.com/gin-gonic/[email protected]/context.go:169 (0x4531861)
github.com/gin-gonic/[email protected]/recovery.go:107 (0x453184c)
github.com/gin-gonic/[email protected]/context.go:169 (0x4530ac6)
github.com/gin-gonic/[email protected]/logger.go:240 (0x4530aa9)
github.com/gin-gonic/[email protected]/context.go:169 (0x4e3688c)
github.com/gin-contrib/[email protected]/sessions.go:65 (0x4e36878)
github.com/gin-gonic/[email protected]/context.go:169 (0x4e30a89)
github.com/gin-contrib/[email protected]/gzip.go:47 (0x4e30a5f)
github.com/gin-gonic/[email protected]/context.go:169 (0x4ef88c1)
github.com/fancybits/channels-server/http.go:330 (0x4ef88ab)
github.com/gin-gonic/[email protected]/context.go:169 (0x4530010)
github.com/gin-gonic/[email protected]/gin.go:598 (0x452fc78)
github.com/gin-gonic/[email protected]/gin.go:554 (0x452f7b1)
net/http/server.go:2879 (0x42d02da)
net/http/server.go:1930 (0x42cb987)
runtime/asm_amd64.s:1581 (0x406b780)

2022/01/30 13:01:00.104626 [TNR] Closed connection to 10719996/2 for ch9.1 KUSA-HD
2022/01/30 13:01:00.181840 [SNR] Statistics for "TV/Earnin' It The NFL's Forward Progress/Earnin' It The NFL's Forward Progress S01E01 The Pipeline 2022-01-30-1157.mpg": ss=96%-98% snq=99%,96%-100% seq=100% bps=9451454,1167104-15294176 pps=809,100-1309
2022/01/30 13:01:00.248749 [DVR] Finished job 1643569020-863 Earnin' It: The NFL's Forward Progress
2022/01/30 13:01:00.447736 [DVR] Waiting 57m59.552273s until next job 1643576340-611 Matter of Fact With Soledad O'Brien
2022/01/30 13:01:03.937580 [DVR] Processing file-39731: TV/Earnin' It The NFL's Forward Progress/Earnin' It The NFL's Forward Progress S01E01 The Pipeline 2022-01-30-1157.mpg
2022/01/30 13:03:14.074892 [HLS] Stopping inactive session file36941-ip10.0.1.228
2022/01/30 13:03:49.074951 [HLS] Stopping inactive session file18814-ip10.0.1.228
2022/01/30 13:05:04.075176 [HLS] Stopping inactive session file39667-ip10.0.1.228