[mythtv-users] GetPlaybackURL: ... should be local, but it can not be found.

Thu Feb 25 03:13:29 UTC 2016

On Thursday, February 25, 2016 02:56:32 AM John P Poet wrote:
> On Wed, Feb 24, 2016 at 7:18 PM Jerome Yuzyk <jerome at supernet.ab.ca> wrote:
> 
> > [0.27.5, Fedora 22]
> >
> > OK, this happens enough that I have to ask again. A recording starts, it's
> > marked auto-commflag, and commflag can't find the file. The recording
> > proceeds successfully and I can start the commflag job when I find it
> > hasn't been done automatically. It happens on either SD or HD tuners,
> > doesn't seem to depend on the channel or load on the BE. Channel-changing
> > is already done by the time commflagging starts, the program starts on
> > time. Commflagging has 2 minutes to determine that the file is there, so
> > that's lots of time. Is this a bug? A known bug?
> >
> > Feb 24 17:30:00 tv mythbackend: 2016-02-24 17:30:00.264249 I  Tuning
> > recording: "NHL Hockey":"Pittsburgh Penguins at Boston Bruins": channel
> > 2159 on cardid 7, sourceid 2
> > Feb 24 17:30:00 tv systemd: Started Session c92 of user root.
> > Feb 24 17:30:00 tv systemd: Starting Session c92 of user root.
> > Feb 24 17:30:00 tv kernel: audit: type=1105 audit(1456360200.748:1550):
> > pid=1635 uid=0 auid=4294967295 ses=4294967295 msg='op=PAM:session_open
> > grantors=pam_keyinit,pam_limits,pam_keyinit,pam_limits,pam_systemd,pam_unix
> > acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
> > Feb 24 17:30:01 tv mythbackend: 2016-02-24 17:30:01.854610 E
> > ProgramInfo(2159_20160225003000.mpg): GetPlaybackURL:
> > '2159_20160225003000.mpg' should be local, but it can not be found.
> > Feb 24 17:30:01 tv mythbackend: 2016-02-24 17:30:01.855447 E
> > ProgramInfo(2159_20160225003000.mpg): GetPlaybackURL:
> > '2159_20160225003000.mpg' should be local, but it can not be found.
> > Feb 24 17:30:01 tv mythbackend: 2016-02-24 17:30:01.857314 I  JobQueue:
> > Commercial Detection Starting for "NHL Hockey":"Pittsburgh Penguins at
> > Boston Bruins" recorded from channel 2159 at 2016-02-25T00:30:00Z
> > Feb 24 17:30:02 tv mythbackend: 2016-02-24 17:30:02.399187 E
> > ProgramInfo(2159_20160225003000.mpg): GetPlaybackURL:
> > '2159_20160225003000.mpg' should be local, but it can not be found.
> >
> >
> Is that log created with "-v channel,record" ?   If so, then the recording
> has not actually started when commercial detection is starting up -- all it
> has done is /start/ to tune it.  There should be further messages when it
> has actually started the recording.
> 
> If that log was not created with "-v channel,record" please change your
> mythbackend startup to include it.
> 

Ohhhh, I see now, my channel-change script (6200ch) wasn't logged until 2 minutes after the recording start time. I didn't clip enough log.

Feb 24 17:30:02 tv kernel: audit: type=1106 audit(1456360202.807:1551): pid=1635 uid=0 auid=4294967295 ses=4294967295 msg='op=PAM:session_close grantors=pam_keyinit,pam_limits,pam_keyinit,pam_limits,pam_systemd,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Feb 24 17:30:02 tv kernel: audit: type=1104 audit(1456360202.808:1552): pid=1635 uid=0 auid=4294967295 ses=4294967295 msg='op=PAM:setcred grantors=pam_env,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success'
Feb 24 17:30:02 tv mythbackend: 2016-02-24 17:30:02.907027 I  LFireDev(946269FFFE90B8F8): Buffered packets 2350 (9400 KB)
Feb 24 17:30:03 tv mythbackend: 2016-02-24 17:30:03.568924 E  DTVSigMon[7](946269FFFE90B8F8): Program #0 not found in PAT!
Feb 24 17:30:03 tv mythbackend: Program Association Section
Feb 24 17:30:03 tv mythbackend: PSIP tableID(0x0) length(13) extension(0x1)
Feb 24 17:30:03 tv mythbackend: version(12) current(1) section(0) last_section(0)
Feb 24 17:30:03 tv mythbackend: tsid(1) programCount(1)
Feb 24 17:30:03 tv mythbackend: program number     1 has PID 0x0061
Feb 24 17:30:03 tv mythbackend: 2016-02-24 17:30:03.568942 E  DTVSigMon[7](946269FFFE90B8F8): But there is only one program in the PAT, so we'll just use it
Feb 24 17:30:03 tv mythbackend: 2016-02-24 17:30:03.607093 I  Updating status for "NHL Hockey":"Pittsburgh Penguins at Boston Bruins" on cardid 7 (Tuning => Recording)
Feb 24 17:30:03 tv mythbackend: 2016-02-24 17:30:03.672711 I  TVRec[7]: rec->GetPathname(): '/recording/tv/2159_20160225003000.mpg'
Feb 24 17:30:03 tv mythbackend: 2016-02-24 17:30:03.677787 I  LFireDev(946269FFFE90B8F8): Buffered packets 2350 (9400 KB)
Feb 24 17:30:03 tv mythbackend: 2016-02-24 17:30:03.713833 I  New DB connection, total: 11

-- 
A little of Jerome's MythTV World: http://mythtv.bss.ab.ca