Several oddities - Recording & System Reboot

Channels DVR Server Troubleshooting
#1

New odd behaviour:

2019/07/26 00:37:00 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 00:37:00 [DVR] Waiting 1h29m59.1501235s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:37:01 [TNR] Opened connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:37:01 [DVR] Waiting 1h29m58.43240266s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:37:01 [DVR] Recording for job 1564115820-180 from 1318CAEB ch432 into "TV/Late Night With Seth Meyers/Late Night With Seth Meyers S06E127 2019-07-25 Michael Moore Brian Michael Bendis Mark Lanegan 2019-07-26-0037.mpg" for 1h0m59.150057236s
2019/07/26 00:37:02 [IDX] Generating video index for job 1564115820-180
2019/07/26 00:37:04 [DVR] Processing file-7676: TV/Jimmy Kimmel Live/Jimmy Kimmel Live S17E101 2019-07-25 Bernie Sanders Eugenio Derbez the Raconteurs 2019-07-25-2335.mpg
2019/07/26 00:40:02 [NAT] Successfully mapped port 8089 using upnp
2019/07/26 00:41:57 [TNR] Cancelling stream 1318CAEB ch432 after 6s read timeout
2019/07/26 00:41:57 [TNR] Closed connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:41:58 [TNR] Closed connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:41:58 [DVR] Job 1564115820-180 Late Night With Seth Meyers ended prematurely: 56m1.865116031s
2019/07/26 00:41:58 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 00:41:58 [DVR] Waiting 1h25m1.342445059s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:42:00 [ERR] Failed to start stream on channel 432 via 1318CAEB: Get http://10.0.0.120:5004/auto/v432?: dial tcp 10.0.0.120:5004: i/o timeout
2019/07/26 00:42:00 [DVR] Error running job 1564115820-180 Late Night With Seth Meyers: could not start stream on channels=[432]: Get http://10.0.0.120:5004/auto/v432?: dial tcp 10.0.0.120:5004: i/o timeout
2019/07/26 00:42:30 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 00:42:30 [DVR] Waiting 1h24m29.20317189s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:42:31 [TNR] Opened connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:42:31 [DVR] Recording for job 1564115820-180 from 1318CAEB ch432 into "TV/Late Night With Seth Meyers/Late Night With Seth Meyers S06E127 2019-07-25 Michael Moore Brian Michael Bendis Mark Lanegan 2019-07-26-0037.mpg" for 55m29.203104625s
2019/07/26 00:51:49 [TNR] Cancelling stream 1318CAEB ch432 after 6s read timeout
2019/07/26 00:51:49 [TNR] Closed connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:51:49 [TNR] Closed connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:51:49 [DVR] Job 1564115820-180 Late Night With Seth Meyers ended prematurely: 46m10.13999692s
2019/07/26 00:51:50 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 00:51:50 [DVR] Waiting 1h15m9.826014872s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:51:52 [ERR] Failed to start stream on channel 432 via 1318CAEB: Get http://10.0.0.120:5004/auto/v432?: dial tcp 10.0.0.120:5004: i/o timeout
2019/07/26 00:51:52 [DVR] Error running job 1564115820-180 Late Night With Seth Meyers: could not start stream on channels=[432]: Get http://10.0.0.120:5004/auto/v432?: dial tcp 10.0.0.120:5004: i/o timeout
2019/07/26 00:52:22 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 00:52:22 [DVR] Waiting 1h14m37.535209712s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:52:22 [TNR] Opened connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:52:22 [DVR] Recording for job 1564115820-180 from 1318CAEB ch432 into "TV/Late Night With Seth Meyers/Late Night With Seth Meyers S06E127 2019-07-25 Michael Moore Brian Michael Bendis Mark Lanegan 2019-07-26-0037.mpg" for 45m37.535141947s
2019/07/26 00:57:25 [SYS] Downloading new version v2019.07.26.0234

BTW: My NAS just started a reboot (on it’s own) right after new version was loaded and installed. The last line on log was not copied for this log extract as it didn’t relate to the issue in above. Will update you after NAS reboot completes.

Channels Community Down?
#2

Con’t

2019/07/26 00:57:37 [SYS] Update downloaded and verified successfully.
2019/07/26 00:59:44 [TNR] Cancelling stream 1318CAEB ch432 after 6s read timeout
2019/07/26 00:59:44 [TNR] Closed connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:59:44 [TNR] Closed connection to 1318CAEB for ch432 NBCHD
2019/07/26 00:59:44 [DVR] Job 1564115820-180 Late Night With Seth Meyers ended prematurely: 38m15.163745542s
2019/07/26 00:59:45 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 00:59:45 [DVR] Waiting 1h7m14.871784223s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 00:59:47 [ERR] Failed to start stream on channel 432 via 1318CAEB: Get http://10.0.0.120:5004/auto/v432?: dial tcp 10.0.0.120:5004: i/o timeout
2019/07/26 00:59:47 [DVR] Error running job 1564115820-180 Late Night With Seth Meyers: could not start stream on channels=[432]: Get http://10.0.0.120:5004/auto/v432?: dial tcp 10.0.0.120:5004: i/o timeout
2019/07/26 01:09:38 [SYS] Starting Channels DVR v2019.07.26.0234 (linux-x86_64 pid:25437) in /share/CACHEDEV1_DATA/.qpkg/ChannelsDVR/channels-dvr/data
2019/07/26 01:09:39 [HDR] Found 1 devices
2019/07/26 01:09:42 [SYS] Started HTTP Server
2019/07/26 01:10:41 [DVR] Recording engine started in /share/easystore/Channels BU 20170805/Channels_Bup/Channels
2019/07/26 01:10:41 [SYS] Bonjour service running for dvr-q251a.local. [10.0.0.228]
2019/07/26 01:10:41 [SYS] Removing old update 2019.07.18.1545
2019/07/26 01:10:42 [NAT] Successfully mapped port 8089 using upnp
2019/07/26 01:10:42 [DVR] Starting job 1564115820-180 Late Night With Seth Meyers on ch=[432 2]
2019/07/26 01:10:42 [DVR] Waiting 56m17.506002819s until next job 1564121220-ch432 Today With Hoda & Jenna
2019/07/26 01:10:43 [TNR] Opened connection to 1318CAEB for ch432 NBCHD
2019/07/26 01:10:43 [DVR] Recording for job 1564115820-180 from 1318CAEB ch432 into "TV/Late Night With Seth Meyers/Late Night With Seth Meyers S06E127 2019-07-25 Michael Moore Brian Michael Bendis Mark Lanegan 2019-07-26-0037.mpg" for 27m17.505931031s
2019/07/26 01:11:00 [IDX] Pruned 678 expired airings from USA-FL61795-X in 5.721143184s.
2019/07/26 01:11:04 [IDX] Pruned 310 expired airings from X-TVE in 3.431590949s.

#3

This indicates an issue on your home network where the dvr was unable to connect to the hdhomerun.

Either the IP changed, the HDHR is not responding or some other network problem.

#4

I'm guessing the HDHR turned off or dropped off the network.

#5

OK, see this on log...but my server is on 10.0.0.228.

How it got changed to .120 is still a ???

Also, can you see any reason the NAS rebooted on it’s own...right after successful update?

See last paragraph on post 1 and also post 2

Edit:

Pulled log at 00.59.00 Did the log extract post 1
Was in the middle of sending post 1 when the NAS started a reboot