SageTV Community

SageTV Community (http://forums.sagetv.com/forums/index.php)
-   Hardware Support (http://forums.sagetv.com/forums/forumdisplay.php?f=9)
-   -   PrimeNetEncoder - HDHomeRun Prime Network Encoder (http://forums.sagetv.com/forums/showthread.php?t=62055)

mayamaniac 10-22-2015 12:24 PM

1 Attachment(s)
I'm getting shitty artifacts on the recordings. Any pointers on where to start to fix this?

http://forums.sagetv.com/forums/atta...1&d=1445538144

jvl711 10-22-2015 12:34 PM

I am assuming that you are using the latest release... Are you using the settings in the example .bat file for launching PrimeNetEncoder? Did you check to see if you are getting these same artifacts with HDHomeRun view app? Can you post your primenetencoder.properties.

mayamaniac 10-22-2015 01:17 PM

Quote:

Originally Posted by jvl711 (Post 579230)
I am assuming that you are using the latest release... Are you using the settings in the example .bat file for launching PrimeNetEncoder? Did you check to see if you are getting these same artifacts with HDHomeRun view app? Can you post your primenetencoder.properties.

Yes, latest 1.25 RC1. Yes on the .bat. No artifacts on the HDHR View app.

PNE.prop file:
Code:


ffmpeg.delay=500
ffmpeg.probesize=5000000
ffmpeg.analyzeduration=5000000
ffmpeg.path=ffmpeg.exe
HDHomeRunConfig.path=C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe
tuners.count=3
discovery.port=8271
discovery.enabled=true
mediaserver.transfer=true
ffmpeg.outputbuffersize=32768
ffmpeg.inputbuffersize=32768
mediaserver.outputbuffersize=32768
tuner0.name=PrimeNetEncoder 13109741-0
tuner0.id=13109741
tuner0.number=0
tuner0.port=7000
tuner0.transcoder.port=5000
tuner0.enabled=true
tuner0.transcode.enabled=false
tuner0.transcode.deinterlace=true
tuner0.transcode.bitrate=4000
tuner0.transcode.scaling=
tuner0.transcode.preset=veryfast
tuner0.transcode.codec=libx264
tuner1.name=PrimeNetEncoder 13109741-1
tuner1.id=13109741
tuner1.number=1
tuner1.port=7001
tuner1.transcoder.port=5001
tuner1.enabled=true
tuner1.transcode.enabled=false
tuner1.transcode.deinterlace=true
tuner1.transcode.bitrate=4000
tuner1.transcode.scaling=
tuner1.transcode.preset=veryfast
tuner1.transcode.codec=libx264
tuner2.name=PrimeNetEncoder 13109741-2
tuner2.id=13109741
tuner2.number=2
tuner2.port=7002
tuner2.transcoder.port=5002
tuner2.enabled=true
tuner2.transcode.enabled=false
tuner2.transcode.deinterlace=true
tuner2.transcode.bitrate=4000
tuner2.transcode.scaling=
tuner2.transcode.preset=veryfast
tuner2.transcode.codec=libx264


nyplayer 10-22-2015 01:19 PM

Can you post your batchfile?

mayamaniac 10-22-2015 01:24 PM

Quote:

Originally Posted by nyplayer (Post 579233)
Can you post your batchfile?

I have not changed it.

Code:

java -XX:-UseBiasedLocking -XX:NewSize=50M -Xms128m -Xmx256m -jar PrimeNetEncoder.jar

nyplayer 10-22-2015 01:27 PM

Quote:

Originally Posted by mayamaniac (Post 579235)
I have not changed it.

Code:

java -XX:-UseBiasedLocking -XX:NewSize=50M -Xms128m -Xmx256m -jar PrimeNetEncoder.jar

If you have it scheduled to run in Windows Scheduler did you change the priority?
http://forums.sagetv.com/forums/show...2&postcount=55

jvl711 10-22-2015 02:00 PM

Quote:

Originally Posted by mayamaniac (Post 579235)
I have not changed it.

Code:

java -XX:-UseBiasedLocking -XX:NewSize=50M -Xms128m -Xmx256m -jar PrimeNetEncoder.jar

Is PrimeNetEncoder on the same machine as Sage?

How often are these glitches happening? Every minute, Every Half Hour, Every Hour...

mayamaniac 10-22-2015 02:30 PM

Quote:

Originally Posted by nyplayer (Post 579236)
If you have it scheduled to run in Windows Scheduler did you change the priority?
http://forums.sagetv.com/forums/show...2&postcount=55

not using windows scheduler.

Quote:

Originally Posted by jvl711 (Post 579242)
Is PrimeNetEncoder on the same machine as Sage?

How often are these glitches happening? Every minute, Every Half Hour, Every Hour...

same machine, every few seconds.

nyplayer 10-22-2015 03:57 PM

Quote:

Originally Posted by mayamaniac (Post 579243)
not using windows scheduler.


same machine, every few seconds.

Are you running this on a Mac ??? if you are like they say in Shark Tank "I am out"

jvl711 10-22-2015 04:29 PM

Quote:

Originally Posted by mayamaniac (Post 579243)
not using windows scheduler.


same machine, every few seconds.

Is this possibly a VMware vmdk performance issue? I am going to lean towards this being a system issue. I do not think anyone else is experiencing this issue.

Did you try rolling back to version 1.0.1 ? If so does the issue still happen.

mayamaniac 10-22-2015 05:39 PM

Quote:

Originally Posted by jvl711 (Post 579246)
Is this possibly a VMware vmdk performance issue? I am going to lean towards this being a system issue. I do not think anyone else is experiencing this issue.

Did you try rolling back to version 1.0.1 ? If so does the issue still happen.

CPU is always under 40%. I'll try to roll back.

phelme 10-23-2015 12:02 AM

Edit 10/23/15: OK, i'm thinking maybe the priority for the task was at the default of 7. thought I changed it to 4 in the XML and re-imported, but I went thought this a couple of times so it may have been reset. we'll run for a while and see how it goes.


since I've come up to v1.2.5 and and also started running as a console app, outside of the SageTV process, I've been having occasional halts. before that when I was running as a class within SageTV and v1.01 it was running great and i never had a single halt. :)

i'm running the the process with parameters from the 1.2.5 .bat file:
"C:\Program Files (x86)\Java\jre6\bin\java.exe" -XX:-UseBiasedLocking -XX:NewSize=50M -Xms128m -Xmx256m -jar "C:\Program Files (x86)\SageTV\SageTV\PrimeNetEncoder.jar"


the latest halt was tonight. I have the tuner log here. Looks like it gave up after 5 seconds. after that Sage fell back to one of my HD-PVR's.

Code:

10/22/2015 20:00:02 - Start commmand received: START PrimeNetEncoder 1310670F-2 Digital TV Tuner|1908935108|707|2891138404338|\\sagetv-server\BigMedia2-Recordings\GreysAnatomy-S12E05-GuessWhosComingtoDinner-40724820-0.ts|Great
10/22/2015 20:00:02 - -------------------------------------------------------------------------------
10/22/2015 20:00:02 - Switching Channel for Tuner: 1310670F 2
10/22/2015 20:00:02 - -------------------------------------------------------------------------------
10/22/2015 20:00:02 - Channel: 707
10/22/2015 20:00:02 - File: GreysAnatomy-S12E05-GuessWhosComingtoDinner-40724820-0.ts
10/22/2015 20:00:02 - UploadID: 1908935108
10/22/2015 20:00:02 - Quality: Great
10/22/2015 20:00:02 - Local IP: 10.0.1.35
10/22/2015 20:00:02 - Listening Port: 7002
10/22/2015 20:00:02 - Stream listening Port: 5002
10/22/2015 20:00:02 - Checking to see if the tuner is locked.
10/22/2015 20:00:02 - Switch channel: 707
10/22/2015 20:00:02 -        Using Lockkey: 469679794
10/22/2015 20:00:02 -        Command output: null
10/22/2015 20:00:02 - Send stream to UDP port: 5002
10/22/2015 20:00:02 -        Using Lockkey: 469679794
10/22/2015 20:00:02 -        Command output: null
10/22/2015 20:00:03 - Passing stream to SageTV unaltered (ffmpeg stream copy)
10/22/2015 20:00:03 - Starting TunerOutput thread for stdin to ffmpeg then stdout to SageTV MediaServer
10/22/2015 20:00:03 - Tuner output thread constructed for UploadID: 1908935108
10/22/2015 20:00:03 - Tuner output thread HDHomeRun(UDP) -> PrimeNetEncoder(SDIN) -> ffmpeg(STDOUT) -> SageTV Media Server(TCP)
10/22/2015 20:00:03 - Sleeping to allow ffmpeg to fully launch: 500
10/22/2015 20:00:03 - Tuner bridge has transfered: 0
10/22/2015 20:00:03 - Sending write open command
10/22/2015 20:00:03 - TunerBridge thread started udpPort: 5002
10/22/2015 20:00:03 - Write open sent successfully
10/22/2015 20:00:03 - Tuner bridge has transfered: 101332
10/22/2015 20:00:03 - Tuner bridge has transfered: 289520
10/22/2015 20:00:04 - Tuner bridge has transfered: 665896
10/22/2015 20:00:04 - Tuner bridge has transfered: 1408120
10/22/2015 20:00:05 - Tuner bridge has transfered: 1718696
10/22/2015 20:00:05 - Tuner bridge has transfered: 1954260
10/22/2015 20:00:05 - Tuner bridge has transfered: 2130604
10/22/2015 20:00:05 - Tuner bridge has transfered: 2170084
10/22/2015 20:00:06 - Tuner bridge has transfered: 2270100
10/22/2015 20:00:06 - -------------------------------------------------------------------------------
10/22/2015 20:00:06 - Stopping Recording: 1310670F 2
10/22/2015 20:00:06 - -------------------------------------------------------------------------------
10/22/2015 20:00:06 - Stopping the TunerOutput thread
10/22/2015 20:00:06 - Send stream to UDP port: 5002
10/22/2015 20:00:06 -        Using Lockkey: 469679794
10/22/2015 20:00:06 - Tuner bridge has transfered: 2479344
10/22/2015 20:00:06 -        Command output: null
10/22/2015 20:00:06 - Switch channel: none
10/22/2015 20:00:06 -        Using Lockkey: 469679794
10/22/2015 20:00:07 - TunerOutput thread exited
10/22/2015 20:00:07 - TunerBridge thread exited
10/22/2015 20:00:07 -        Command output: null
10/22/2015 20:00:07 - WARNING: Tuner has not produced data in (2750ms)
10/22/2015 20:00:07 - Stopping the encoder process
10/22/2015 20:00:07 - waiting for the process to stop
10/22/2015 20:00:07 - Recording stopped

here's my properties file:

Code:

ffmpeg.delay=1000
ffmpeg.probesize=5000000
ffmpeg.analyzeduration=5000000
ffmpeg.path=ffmpeg.exe
HDHomeRunConfig.path="C:\Program Files (x86)\Silicondust\HDHomeRun\hdhomerun_config.exe"
tuners.count=3
discovery.port=8271
discovery.enabled=true
mediaserver.transfer=true
tuner0.name=PrimeNetEncoder 1310670F-0
tuner0.id=1310670F
tuner0.number=0
tuner0.port=7000
tuner0.transcoder.port=5000
tuner0.enabled=true
tuner0.transcode.enabled=false
tuner0.transcode.deinterlace=true
tuner0.transcode.bitrate=4000
tuner0.transcode.scaling=
tuner0.transcode.preset=veryfast
tuner0.transcode.codec=libx264
tuner1.name=PrimeNetEncoder 1310670F-1
tuner1.id=1310670F
tuner1.number=1
tuner1.port=7001
tuner1.transcoder.port=5001
tuner1.enabled=true
tuner1.transcode.enabled=false
tuner1.transcode.deinterlace=true
tuner1.transcode.bitrate=4000
tuner1.transcode.scaling=
tuner1.transcode.preset=veryfast
tuner1.transcode.codec=libx264
tuner2.name=PrimeNetEncoder 1310670F-2
tuner2.id=1310670F
tuner2.number=2
tuner2.port=7002
tuner2.transcoder.port=5002
tuner2.enabled=true
tuner2.transcode.enabled=false
tuner2.transcode.deinterlace=true
tuner2.transcode.bitrate=4000
tuner2.transcode.scaling=
tuner2.transcode.preset=veryfast
tuner2.transcode.codec=libx264
ffmpeg.outputbuffersize=32768
ffmpeg.inputbuffersize=32768
mediaserver.outputbuffersize=32768

the halt the night before was Jeopardy!. there were 16x failures marked in system messages. here's a partial log from that.

i have a hunch the failures are happening when more than one recording starts simultaneously. not all PrimeNetEncoder recordings are failing though since I upgraded.

Code:


10/21/2015 18:59:06 - Start commmand received: START PrimeNetEncoder 1310670F-0 Digital TV Tuner|1365691338|707|2890958293796|\\sagetv-server\BigMedia2-Recordings\Jeopardy-S32E28-40699185-0.ts|Great
10/21/2015 18:59:06 - -------------------------------------------------------------------------------
10/21/2015 18:59:06 - Switching Channel for Tuner: 1310670F 0
10/21/2015 18:59:06 - -------------------------------------------------------------------------------
10/21/2015 18:59:06 - Channel: 707
10/21/2015 18:59:06 - File: Jeopardy-S32E28-40699185-0.ts
10/21/2015 18:59:06 - UploadID: 1365691338
10/21/2015 18:59:06 - Quality: Great
10/21/2015 18:59:06 - Local IP: 127.0.0.1
10/21/2015 18:59:06 - Listening Port: 7000
10/21/2015 18:59:06 - Stream listening Port: 5000
10/21/2015 18:59:06 - Checking to see if the tuner is locked.
10/21/2015 18:59:07 - Switch channel: 707
10/21/2015 18:59:07 -        Using Lockkey: 1623585423
10/21/2015 18:59:07 -        Command output: null
10/21/2015 18:59:07 - Send stream to UDP port: 5000
10/21/2015 18:59:07 -        Using Lockkey: 1623585423
10/21/2015 18:59:07 -        Command output: null
10/21/2015 18:59:07 - Passing stream to SageTV unaltered (ffmpeg stream copy)
10/21/2015 18:59:08 - Starting TunerOutput thread for stdin to ffmpeg then stdout to SageTV MediaServer
10/21/2015 18:59:08 - Tuner output thread constructed for UploadID: 1365691338
10/21/2015 18:59:08 - Tuner output thread HDHomeRun(UDP) -> PrimeNetEncoder(SDIN) -> ffmpeg(STDOUT) -> SageTV Media Server(TCP)
10/21/2015 18:59:08 - Sleeping to allow ffmpeg to fully launch: 500
10/21/2015 18:59:08 - Sending write open command
10/21/2015 18:59:08 - Tuner bridge has transfered: 0
10/21/2015 18:59:08 - TunerBridge thread started udpPort: 5000
10/21/2015 18:59:08 - Write open sent successfully
10/21/2015 18:59:08 - Tuner bridge has transfered: 6000
10/21/2015 18:59:08 - Tuner bridge has transfered: 13500
10/21/2015 18:59:08 - Tuner bridge has transfered: 22500
10/21/2015 18:59:09 - Tuner bridge has transfered: 33000
10/21/2015 18:59:09 - Tuner bridge has transfered: 45000
10/21/2015 18:59:09 - Tuner bridge has transfered: 52500
10/21/2015 18:59:10 - Tuner bridge has transfered: 60000
10/21/2015 18:59:10 - Tuner bridge has transfered: 67500
10/21/2015 18:59:10 - Tuner bridge has transfered: 75000
10/21/2015 18:59:10 - Tuner bridge has transfered: 82500
10/21/2015 18:59:11 - Tuner bridge has transfered: 90000
10/21/2015 18:59:11 - Tuner bridge has transfered: 97500
10/21/2015 18:59:11 - Tuner bridge has transfered: 106500
10/21/2015 18:59:11 - Tuner bridge has transfered: 114000
10/21/2015 18:59:12 - Tuner bridge has transfered: 121500
10/21/2015 18:59:12 - Tuner bridge has transfered: 129000
10/21/2015 18:59:12 - Tuner bridge has transfered: 136500
10/21/2015 18:59:12 - Tuner bridge has transfered: 144000
10/21/2015 18:59:13 - Tuner bridge has transfered: 151500
10/21/2015 18:59:13 - Tuner bridge has transfered: 159000
10/21/2015 18:59:13 - No data transfered in 6000ms.  Reseting tuner channel and stream.
10/21/2015 18:59:13 - Switch channel: 707
10/21/2015 18:59:13 -        Using Lockkey: 1623585423
10/21/2015 18:59:13 -        Command output: null
10/21/2015 18:59:13 - Send stream to UDP port: 5000
10/21/2015 18:59:13 -        Using Lockkey: 1623585423
10/21/2015 18:59:13 -        Command output: null
10/21/2015 18:59:13 - Tuner bridge has transfered: 169500
10/21/2015 18:59:14 - Tuner bridge has transfered: 177000
10/21/2015 18:59:14 - Tuner bridge has transfered: 184500
10/21/2015 18:59:14 - Tuner bridge has transfered: 192000
10/21/2015 18:59:14 - Tuner bridge has transfered: 199500
10/21/2015 18:59:15 - Tuner bridge has transfered: 207000
10/21/2015 18:59:15 - Tuner bridge has transfered: 214500
10/21/2015 18:59:15 - Tuner bridge has transfered: 222000
10/21/2015 18:59:15 - Tuner bridge has transfered: 229500
10/21/2015 18:59:16 - Tuner bridge has transfered: 237000
10/21/2015 18:59:16 - Tuner bridge has transfered: 244500
10/21/2015 18:59:16 - Tuner bridge has transfered: 252000
10/21/2015 18:59:16 - Tuner bridge has transfered: 259500
10/21/2015 18:59:17 - Tuner bridge has transfered: 268500
10/21/2015 18:59:17 - Tuner bridge has transfered: 276000
10/21/2015 18:59:17 - Tuner bridge has transfered: 283500
10/21/2015 18:59:17 - Tuner bridge has transfered: 291000
10/21/2015 18:59:18 - Tuner bridge has transfered: 298500
10/21/2015 18:59:18 - Tuner bridge has transfered: 306000
10/21/2015 18:59:18 - Tuner bridge has transfered: 313500
10/21/2015 18:59:18 - No data transfered in 6000ms.  Reseting tuner channel and stream.
10/21/2015 18:59:18 - Switch channel: 707
10/21/2015 18:59:18 -        Using Lockkey: 1623585423
10/21/2015 18:59:18 -        Command output: null
10/21/2015 18:59:18 - Send stream to UDP port: 5000
10/21/2015 18:59:18 -        Using Lockkey: 1623585423
10/21/2015 18:59:18 -        Command output: null
10/21/2015 18:59:19 - Tuner bridge has transfered: 324000
10/21/2015 18:59:19 - Tuner bridge has transfered: 331500
10/21/2015 18:59:19 - Tuner bridge has transfered: 339000
10/21/2015 18:59:19 - Tuner bridge has transfered: 346500
10/21/2015 18:59:20 - Tuner bridge has transfered: 354000
10/21/2015 18:59:20 - Tuner bridge has transfered: 361500
10/21/2015 18:59:20 - Tuner bridge has transfered: 370500
10/21/2015 18:59:20 - WARNING: Tuner has not produced data in (12000ms)
10/21/2015 18:59:44 - TunerOutput thread exited
10/21/2015 18:59:44 - TunerBridge thread exited
10/21/2015 19:00:52 - -------------------------------------------------------------------------------
10/21/2015 19:00:52 - Stopping Recording: 1310670F 0
10/21/2015 19:00:52 - -------------------------------------------------------------------------------
10/21/2015 19:00:52 - Stopping the TunerOutput thread
10/21/2015 19:00:52 - Send stream to UDP port: 5000
10/21/2015 19:00:52 -        Using Lockkey: 1623585423
10/21/2015 19:00:52 -        Command output: null
10/21/2015 19:00:52 - Switch channel: none
10/21/2015 19:00:52 -        Using Lockkey: 1623585423
10/21/2015 19:00:52 -        Command output: null
10/21/2015 19:00:52 - Stopping the encoder process
10/21/2015 19:00:52 - waiting for the process to stop
10/21/2015 19:00:52 - Recording stopped
10/21/2015 19:00:52 - Start commmand received: START PrimeNetEncoder 1310670F-0 Digital TV Tuner|1067724237|707|2890958505324|\\sagetv-server\BigMedia2-Recordings\Jeopardy-S32E28-40699185-1.ts|Great
10/21/2015 19:00:52 - -------------------------------------------------------------------------------
10/21/2015 19:00:52 - Switching Channel for Tuner: 1310670F 0
10/21/2015 19:00:52 - -------------------------------------------------------------------------------
10/21/2015 19:00:52 - Channel: 707
10/21/2015 19:00:52 - File: Jeopardy-S32E28-40699185-1.ts
10/21/2015 19:00:52 - UploadID: 1067724237
10/21/2015 19:00:52 - Quality: Great
10/21/2015 19:00:52 - Local IP: 127.0.0.1
10/21/2015 19:00:52 - Listening Port: 7000
10/21/2015 19:00:52 - Stream listening Port: 5000
10/21/2015 19:00:52 - Checking to see if the tuner is locked.
10/21/2015 19:00:52 - Switch channel: 707
10/21/2015 19:00:52 -        Using Lockkey: 122333007
10/21/2015 19:00:52 -        Command output: null
10/21/2015 19:00:52 - Send stream to UDP port: 5000
10/21/2015 19:00:52 -        Using Lockkey: 122333007
10/21/2015 19:00:52 -        Command output: null
10/21/2015 19:00:52 - Passing stream to SageTV unaltered (ffmpeg stream copy)
10/21/2015 19:00:52 - Starting TunerOutput thread for stdin to ffmpeg then stdout to SageTV MediaServer
10/21/2015 19:00:52 - Tuner output thread constructed for UploadID: 1067724237
10/21/2015 19:00:52 - Tuner output thread HDHomeRun(UDP) -> PrimeNetEncoder(SDIN) -> ffmpeg(STDOUT) -> SageTV Media Server(TCP)
10/21/2015 19:00:52 - Sleeping to allow ffmpeg to fully launch: 500
10/21/2015 19:00:52 - Tuner bridge has transfered: 0
10/21/2015 19:00:52 - TunerBridge thread started udpPort: 5000
10/21/2015 19:00:52 - Sending write open command
10/21/2015 19:00:52 - Write open sent successfully
10/21/2015 19:00:53 - Tuner bridge has transfered: 6000
10/21/2015 19:00:53 - Tuner bridge has transfered: 15000
10/21/2015 19:00:53 - Tuner bridge has transfered: 22500
10/21/2015 19:00:53 - Tuner bridge has transfered: 30000
10/21/2015 19:00:54 - Tuner bridge has transfered: 37500
10/21/2015 19:00:54 - Tuner bridge has transfered: 45000
10/21/2015 19:00:54 - Tuner bridge has transfered: 52500
10/21/2015 19:00:54 - Tuner bridge has transfered: 61500
10/21/2015 19:00:55 - Tuner bridge has transfered: 69000
10/21/2015 19:00:55 - Tuner bridge has transfered: 76500
10/21/2015 19:00:55 - Tuner bridge has transfered: 84000
10/21/2015 19:00:55 - Tuner bridge has transfered: 91500
10/21/2015 19:00:56 - Tuner bridge has transfered: 99000
10/21/2015 19:00:56 - Tuner bridge has transfered: 106500
10/21/2015 19:00:56 - Tuner bridge has transfered: 114000
10/21/2015 19:00:56 - Tuner bridge has transfered: 121500
10/21/2015 19:00:57 - Tuner bridge has transfered: 129000
10/21/2015 19:00:57 - Tuner bridge has transfered: 136500
10/21/2015 19:00:57 - Tuner bridge has transfered: 144000
10/21/2015 19:00:58 - Tuner bridge has transfered: 151500
10/21/2015 19:00:58 - No data transfered in 6000ms.  Reseting tuner channel and stream.
10/21/2015 19:00:58 - Switch channel: 707
10/21/2015 19:00:58 -        Using Lockkey: 122333007
10/21/2015 19:00:58 -        Command output: null
10/21/2015 19:00:58 - Send stream to UDP port: 5000
10/21/2015 19:00:58 -        Using Lockkey: 122333007
10/21/2015 19:00:58 -        Command output: null
10/21/2015 19:00:58 - Tuner bridge has transfered: 162000
10/21/2015 19:00:58 - Tuner bridge has transfered: 169500
10/21/2015 19:00:58 - Tuner bridge has transfered: 177000
10/21/2015 19:00:59 - Tuner bridge has transfered: 184500
10/21/2015 19:00:59 - Tuner bridge has transfered: 192000
10/21/2015 19:00:59 - Tuner bridge has transfered: 199500
10/21/2015 19:00:59 - Tuner bridge has transfered: 207000
10/21/2015 19:01:00 - Tuner bridge has transfered: 214500
10/21/2015 19:01:00 - Tuner bridge has transfered: 223500
10/21/2015 19:01:00 - Tuner bridge has transfered: 231000
10/21/2015 19:01:00 - Tuner bridge has transfered: 238500
10/21/2015 19:01:01 - Tuner bridge has transfered: 246000
10/21/2015 19:01:01 - Tuner bridge has transfered: 253500
10/21/2015 19:01:01 - Tuner bridge has transfered: 261000
10/21/2015 19:01:01 - Tuner bridge has transfered: 268500
10/21/2015 19:01:02 - Tuner bridge has transfered: 276000
10/21/2015 19:01:02 - Tuner bridge has transfered: 283500
10/21/2015 19:01:02 - Tuner bridge has transfered: 291000
10/21/2015 19:01:02 - Tuner bridge has transfered: 298500
10/21/2015 19:01:03 - Tuner bridge has transfered: 306000
10/21/2015 19:01:03 - No data transfered in 6000ms.  Reseting tuner channel and stream.
10/21/2015 19:01:03 - Switch channel: 707
10/21/2015 19:01:03 -        Using Lockkey: 122333007
10/21/2015 19:01:03 -        Command output: null
10/21/2015 19:01:03 - Send stream to UDP port: 5000
10/21/2015 19:01:03 -        Using Lockkey: 122333007
10/21/2015 19:01:03 -        Command output: null
10/21/2015 19:01:03 - Tuner bridge has transfered: 316500
10/21/2015 19:01:03 - Tuner bridge has transfered: 324000
10/21/2015 19:01:04 - Tuner bridge has transfered: 331500
10/21/2015 19:01:04 - Tuner bridge has transfered: 339000
10/21/2015 19:01:04 - Tuner bridge has transfered: 346500
10/21/2015 19:01:04 - Tuner bridge has transfered: 354000
10/21/2015 19:01:05 - Tuner bridge has transfered: 361500
10/21/2015 19:01:05 - WARNING: Tuner has not produced data in (12000ms)
10/21/2015 19:01:28 - TunerOutput thread exited
10/21/2015 19:01:28 - TunerBridge thread exited
10/21/2015 19:02:37 - -------------------------------------------------------------------------------
10/21/2015 19:02:37 - Stopping Recording: 1310670F 0
10/21/2015 19:02:37 - -------------------------------------------------------------------------------
10/21/2015 19:02:37 - Stopping the TunerOutput thread
10/21/2015 19:02:37 - Send stream to UDP port: 5000
10/21/2015 19:02:37 -        Using Lockkey: 122333007
10/21/2015 19:02:37 -        Command output: null
10/21/2015 19:02:37 - Switch channel: none
10/21/2015 19:02:37 -        Using Lockkey: 122333007
10/21/2015 19:02:37 -        Command output: null
10/21/2015 19:02:37 - Stopping the encoder process
10/21/2015 19:02:37 - waiting for the process to stop
10/21/2015 19:02:37 - Recording stopped
10/21/2015 19:02:37 - Start commmand received: START PrimeNetEncoder 1310670F-0 Digital TV Tuner|1738085874|707|2890958715356|\\sagetv-server\BigMedia2-Recordings\Jeopardy-S32E28-40699185-2.ts|Great
10/21/2015 19:02:37 - -------------------------------------------------------------------------------
10/21/2015 19:02:37 - Switching Channel for Tuner: 1310670F 0
10/21/2015 19:02:37 - -------------------------------------------------------------------------------
10/21/2015 19:02:37 - Channel: 707
10/21/2015 19:02:37 - File: Jeopardy-S32E28-40699185-2.ts
10/21/2015 19:02:37 - UploadID: 1738085874
10/21/2015 19:02:37 - Quality: Great
10/21/2015 19:02:37 - Local IP: 127.0.0.1
10/21/2015 19:02:37 - Listening Port: 7000
10/21/2015 19:02:37 - Stream listening Port: 5000
10/21/2015 19:02:37 - Checking to see if the tuner is locked.
10/21/2015 19:02:37 - Switch channel: 707
10/21/2015 19:02:37 -        Using Lockkey: 1273189716
10/21/2015 19:02:37 -        Command output: null
10/21/2015 19:02:37 - Send stream to UDP port: 5000
10/21/2015 19:02:37 -        Using Lockkey: 1273189716
10/21/2015 19:02:37 -        Command output: null
10/21/2015 19:02:37 - Passing stream to SageTV unaltered (ffmpeg stream copy)
10/21/2015 19:02:37 - Starting TunerOutput thread for stdin to ffmpeg then stdout to SageTV MediaServer
10/21/2015 19:02:37 - Tuner output thread constructed for UploadID: 1738085874
10/21/2015 19:02:37 - Tuner output thread HDHomeRun(UDP) -> PrimeNetEncoder(SDIN) -> ffmpeg(STDOUT) -> SageTV Media Server(TCP)
10/21/2015 19:02:37 - Sleeping to allow ffmpeg to fully launch: 500
10/21/2015 19:02:37 - Tuner bridge has transfered: 0
10/21/2015 19:02:37 - TunerBridge thread started udpPort: 5000
10/21/2015 19:02:37 - Sending write open command
10/21/2015 19:02:37 - Write open sent successfully
10/21/2015 19:02:38 - Tuner bridge has transfered: 6000
10/21/2015 19:02:38 - Tuner bridge has transfered: 13500
10/21/2015 19:02:38 - Tuner bridge has transfered: 24000
10/21/2015 19:02:38 - Tuner bridge has transfered: 31500
10/21/2015 19:02:39 - Tuner bridge has transfered: 39000
10/21/2015 19:02:39 - Tuner bridge has transfered: 46500
10/21/2015 19:02:39 - Tuner bridge has transfered: 54000
10/21/2015 19:02:39 - Tuner bridge has transfered: 61500
10/21/2015 19:02:40 - Tuner bridge has transfered: 69000
10/21/2015 19:02:40 - Tuner bridge has transfered: 76500
10/21/2015 19:02:40 - Tuner bridge has transfered: 84000
10/21/2015 19:02:41 - Tuner bridge has transfered: 91500
10/21/2015 19:02:41 - Tuner bridge has transfered: 99000
10/21/2015 19:02:41 - Tuner bridge has transfered: 106500
10/21/2015 19:02:41 - Tuner bridge has transfered: 114000
10/21/2015 19:02:42 - Tuner bridge has transfered: 121500
10/21/2015 19:02:42 - Tuner bridge has transfered: 129000
10/21/2015 19:02:42 - Tuner bridge has transfered: 138000
10/21/2015 19:02:42 - Tuner bridge has transfered: 145500
10/21/2015 19:02:43 - Tuner bridge has transfered: 153000
10/21/2015 19:02:43 - No data transfered in 6000ms.  Reseting tuner channel and stream.
10/21/2015 19:02:43 - Switch channel: 707
10/21/2015 19:02:43 -        Using Lockkey: 1273189716
10/21/2015 19:02:43 -        Command output: null
10/21/2015 19:02:43 - Send stream to UDP port: 5000
10/21/2015 19:02:43 -        Using Lockkey: 1273189716
10/21/2015 19:02:43 -        Command output: null
10/21/2015 19:02:43 - Tuner bridge has transfered: 162000
10/21/2015 19:02:43 - Tuner bridge has transfered: 171000
10/21/2015 19:02:43 - Tuner bridge has transfered: 178500
10/21/2015 19:02:44 - Tuner bridge has transfered: 186000
10/21/2015 19:02:44 - Tuner bridge has transfered: 193500
10/21/2015 19:02:44 - Tuner bridge has transfered: 201000
10/21/2015 19:02:44 - Tuner bridge has transfered: 208500
10/21/2015 19:02:45 - Tuner bridge has transfered: 216000
10/21/2015 19:02:45 - Tuner bridge has transfered: 223500
10/21/2015 19:02:45 - Tuner bridge has transfered: 231000
10/21/2015 19:02:45 - Tuner bridge has transfered: 238500
10/21/2015 19:02:46 - Tuner bridge has transfered: 246000
10/21/2015 19:02:46 - Tuner bridge has transfered: 253500
10/21/2015 19:02:46 - Tuner bridge has transfered: 261000
10/21/2015 19:02:46 - Tuner bridge has transfered: 268500
10/21/2015 19:02:47 - Tuner bridge has transfered: 276000
10/21/2015 19:02:47 - Tuner bridge has transfered: 283500
10/21/2015 19:02:47 - Tuner bridge has transfered: 292500
10/21/2015 19:02:47 - Tuner bridge has transfered: 300000
10/21/2015 19:02:48 - Tuner bridge has transfered: 307500
10/21/2015 19:02:48 - No data transfered in 6000ms.  Reseting tuner channel and stream.
10/21/2015 19:02:48 - Switch channel: 707
10/21/2015 19:02:48 -        Using Lockkey: 1273189716
10/21/2015 19:02:48 -        Command output: null
10/21/2015 19:02:48 - Send stream to UDP port: 5000
10/21/2015 19:02:48 -        Using Lockkey: 1273189716
10/21/2015 19:02:48 -        Command output: null
10/21/2015 19:02:48 - Tuner bridge has transfered: 318000
10/21/2015 19:02:48 - Tuner bridge has transfered: 325500
10/21/2015 19:02:49 - Tuner bridge has transfered: 333000
10/21/2015 19:02:49 - Tuner bridge has transfered: 340500
10/21/2015 19:02:49 - Tuner bridge has transfered: 348000
10/21/2015 19:02:49 - Tuner bridge has transfered: 355500
10/21/2015 19:02:50 - Tuner bridge has transfered: 363000
10/21/2015 19:02:50 - WARNING: Tuner has not produced data in (12000ms)
10/21/2015 19:03:13 - TunerOutput thread exited
10/21/2015 19:03:13 - TunerBridge thread exited
10/21/2015 19:04:22 - -------------------------------------------------------------------------------
10/21/2015 19:04:22 - Stopping Recording: 1310670F 0
10/21/2015 19:04:22 - -------------------------------------------------------------------------------
10/21/2015 19:04:22 - Stopping the TunerOutput thread


jvl711 10-23-2015 01:51 PM

So the first halt I can not explain. I can think of no reason Sage would give up on a recording within 6 seconds. I would call that a fluke.

The second recording I can not explain. I am going to need to add some more logging to the code. I need to verify that ffmpeg is running, and that there are no copy protection flags present. I may also decide on my reset tuner code to also restart ffmpeg. Right now it is just changing the channel again, and it is setting the stream ip:port again on the tuner.

I will look into making these changes soon.

Josh

fresnoboy 10-23-2015 10:11 PM

Quote:

Originally Posted by jvl711 (Post 579246)
Is this possibly a VMware vmdk performance issue? I am going to lean towards this being a system issue. I do not think anyone else is experiencing this issue.

Did you try rolling back to version 1.0.1 ? If so does the issue still happen.

I am having this exact same issue on my own vmware system. Exact same symptoms and config as mayamaniac.

It happened to me moving from old hardware to a new much more powerful server and I updated the to 1.2.5 at the same time. I reverted back to the old server running 1.0.1 of the encoder which works just fine (to the same NAS etc..)

I am doing a bit of travel, but when I am back I will try and move VM over to the new hardware and not upgrade to 1.2.5, but just leave the config exactly the same and see if that works fine too.

Does the plugin do synchronous writes or something weird? Usually when I have seen this problem before it's because the system can't handle writes properly because of lack of buffering or some other issue resulting in not all the data being written to the file, resulting in the corruption that mayamaniac captured in the photo.

This is why I was asking what all those batch line parameters meant, as I am trying to debug where the data might be getting lost.

Thanks!
Mike

jvl711 10-24-2015 06:31 AM

Quote:

Originally Posted by fresnoboy (Post 579304)
I am having this exact same issue on my own vmware system. Exact same symptoms and config as mayamaniac.

It happened to me moving from old hardware to a new much more powerful server and I updated the to 1.2.5 at the same time. I reverted back to the old server running 1.0.1 of the encoder which works just fine (to the same NAS etc..)

I am doing a bit of travel, but when I am back I will try and move VM over to the new hardware and not upgrade to 1.2.5, but just leave the config exactly the same and see if that works fine too.

Does the plugin do synchronous writes or something weird? Usually when I have seen this problem before it's because the system can't handle writes properly because of lack of buffering or some other issue resulting in not all the data being written to the file, resulting in the corruption that mayamaniac captured in the photo.

This is why I was asking what all those batch line parameters meant, as I am trying to debug where the data might be getting lost.

Thanks!
Mike

The file writing method is a good theory. In version 1.0.1 ffmpeg was doing the writing. In 1.2.5 SageTV medianserver is doing thwe file writing. I am not sure how well tested the option is, but you could try setting mediaserver.transfer to false. In that case either PrimeNetEncoder or ffmpeg would handle writing.

fresnoboy 10-24-2015 12:10 PM

Quote:

Originally Posted by jvl711 (Post 579311)
The file writing method is a good theory. In version 1.0.1 ffmpeg was doing the writing. In 1.2.5 SageTV medianserver is doing thwe file writing. I am not sure how well tested the option is, but you could try setting mediaserver.transfer to false. In that case either PrimeNetEncoder or ffmpeg would handle writing.

Ah, that makes sense. I was unaware of the media server writing capability - I don't think I've ever used a plugin that used that to write to the filesystem.

Will try this and see what happens.

Thanks again for all your work on this encoder!

Mike

mayamaniac 10-26-2015 03:18 PM

Quote:

Originally Posted by jvl711 (Post 579311)
The file writing method is a good theory. In version 1.0.1 ffmpeg was doing the writing. In 1.2.5 SageTV medianserver is doing thwe file writing. I am not sure how well tested the option is, but you could try setting mediaserver.transfer to false. In that case either PrimeNetEncoder or ffmpeg would handle writing.

I just tested it. Set mediaserver.transfer=false fixed it. Many thanks to both Mike and Josh for figuring it out. :goodjob:

Edit: Just wondering, is there an advantage to having SageTV mediaserver write the file instead of ffmpeg?

Fuzzy 10-26-2015 04:25 PM

Quote:

Originally Posted by mayamaniac (Post 579394)
I just tested it. Set mediaserver.transfer=false fixed it. Many thanks to both Mike and Josh for figuring it out. :goodjob:

Edit: Just wondering, is there an advantage to having SageTV mediaserver write the file instead of ffmpeg?

biggest advantage is permissions immunity. Sage is obviously going to have permissions to write to the file, while a network encoder, especially one on a different system, is not guaranteed to have it worked out. This sort of skips that step.

mayamaniac 10-26-2015 05:00 PM

Quote:

Originally Posted by Fuzzy (Post 579396)
biggest advantage is permissions immunity.

There's no such thing as permission immunity. :P

Since I'm running everything on the same machine, it shouldn't make any difference then

mayamaniac 10-27-2015 02:11 PM

Looks like I spoke to soon. Switching mediaserver.transfer=false reduces the write errors glitches, but not completely. It's about 80% less, but that's with one recording going. When 2 or 3 going at the same time, the glitches are 10 times worse. This problem is only with the HDHR Prime recordings, the regular HDHR OTA tuner records without issues.


All times are GMT -6. The time now is 12:36 AM.

Powered by vBulletin® Version 3.8.11
Copyright ©2000 - 2023, vBulletin Solutions Inc.
Copyright 2003-2005 SageTV, LLC. All rights reserved.